builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1471529135.75 results: success (0) buildid: 20160816222215 builduid: 7115bec0a27d40b5823a93ba3cbff05c revision: 5b442b4e42c3a3a5a8b29746e4639eec4707c913 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 07:05:35.749991) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 07:05:35.750435) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 07:05:35.750708) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 07:05:35.778432) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 07:05:35.778765) ========= 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=20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-18 07:05:35-- 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% 66.9M=0s 2016-08-18 07:05:35 (66.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177983 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 07:05:35.989187) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 07:05:35.989507) ========= 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=20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.129957 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 07:05:36.131669) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 07:05:36.132039) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 5b442b4e42c3a3a5a8b29746e4639eec4707c913 --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 5b442b4e42c3a3a5a8b29746e4639eec4707c913 --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=20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-18 07:05:36,191 truncating revision to first 12 chars 2016-08-18 07:05:36,191 Setting DEBUG logging. 2016-08-18 07:05:36,191 attempt 1/10 2016-08-18 07:05:36,191 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/5b442b4e42c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-18 07:05:36,534 unpacking tar archive at: autoland-5b442b4e42c3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.695312 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 07:05:36.844688) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 07:05:36.845009) ========= script_repo_revision: 5b442b4e42c3a3a5a8b29746e4639eec4707c913 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 07:05:36.848466) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 07:05:36.848742) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 07:05:36.859525) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-08-18 07:05:36.859817) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:05:37 INFO - MultiFileLogger online at 20160818 07:05:37 in /builds/slave/test 07:05:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 07:05:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:05:37 INFO - {'append_to_log': False, 07:05:37 INFO - 'base_work_dir': '/builds/slave/test', 07:05:37 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 07:05:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:05:37 INFO - 'branch': 'Autoland-Non-PGO', 07:05:37 INFO - 'buildbot_json_path': 'buildprops.json', 07:05:37 INFO - 'config_files': ('talos/linux_config.py',), 07:05:37 INFO - 'default_actions': ('clobber', 07:05:37 INFO - 'read-buildbot-config', 07:05:37 INFO - 'download-and-extract', 07:05:37 INFO - 'populate-webroot', 07:05:37 INFO - 'create-virtualenv', 07:05:37 INFO - 'install', 07:05:37 INFO - 'run-tests'), 07:05:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:05:37 INFO - 'download_minidump_stackwalk': True, 07:05:37 INFO - 'download_symbols': 'ondemand', 07:05:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:05:37 INFO - 'tooltool.py': '/tools/tooltool.py', 07:05:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:05:37 INFO - '/tools/misc-python/virtualenv.py')}, 07:05:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:05:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:05:37 INFO - 'installer_path': 'installer.exe', 07:05:37 INFO - 'log_level': 'info', 07:05:37 INFO - 'log_name': 'talos', 07:05:37 INFO - 'log_to_console': True, 07:05:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:05:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:05:37 INFO - 'opt_config_files': (), 07:05:37 INFO - 'pip_index': False, 07:05:37 INFO - 'sps_profile': False, 07:05:37 INFO - 'sps_profile_interval': 0, 07:05:37 INFO - 'suite': 'dromaeojs', 07:05:37 INFO - 'system_bits': '32', 07:05:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:05:37 INFO - 'title': 'talos-linux64-ix-015', 07:05:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:05:37 INFO - 'use_talos_json': True, 07:05:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:05:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:05:37 INFO - 'work_dir': 'build'} 07:05:37 INFO - [mozharness: 2016-08-18 14:05:37.107369Z] Running clobber step. 07:05:37 INFO - Running pre-action listener: _resource_record_pre_action 07:05:37 INFO - Running main action method: clobber 07:05:37 INFO - rmtree: /builds/slave/test/build 07:05:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:05:38 INFO - Running post-action listener: _resource_record_post_action 07:05:38 INFO - [mozharness: 2016-08-18 14:05:38.943263Z] Finished clobber step (success) 07:05:38 INFO - [mozharness: 2016-08-18 14:05:38.943435Z] Running read-buildbot-config step. 07:05:38 INFO - Running pre-action listener: _resource_record_pre_action 07:05:38 INFO - Running main action method: read_buildbot_config 07:05:38 INFO - Using buildbot properties: 07:05:38 INFO - { 07:05:38 INFO - "project": "", 07:05:38 INFO - "product": "firefox", 07:05:38 INFO - "script_repo_revision": "production", 07:05:38 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 07:05:38 INFO - "repository": "", 07:05:38 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 07:05:38 INFO - "buildid": "20160816222215", 07:05:38 INFO - "pgo_build": "False", 07:05:38 INFO - "basedir": "/builds/slave/test", 07:05:38 INFO - "buildnumber": 269, 07:05:38 INFO - "slavename": "talos-linux64-ix-015", 07:05:38 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:05:38 INFO - "platform": "ubuntu64_hw", 07:05:38 INFO - "scheduler": "tests-autoland-linux64-talos", 07:05:38 INFO - "branch": "autoland", 07:05:38 INFO - "repo_path": "integration/autoland", 07:05:38 INFO - "revision": "5b442b4e42c3a3a5a8b29746e4639eec4707c913", 07:05:38 INFO - "stage_platform": "linux64", 07:05:38 INFO - "builduid": "7115bec0a27d40b5823a93ba3cbff05c", 07:05:38 INFO - "slavebuilddir": "test" 07:05:38 INFO - } 07:05:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/D-pCWEEQSYmtHEo9I9KBdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 07:05:38 INFO - Running post-action listener: _resource_record_post_action 07:05:38 INFO - [mozharness: 2016-08-18 14:05:38.946891Z] Finished read-buildbot-config step (success) 07:05:38 INFO - [mozharness: 2016-08-18 14:05:38.947016Z] Running download-and-extract step. 07:05:38 INFO - Running pre-action listener: _resource_record_pre_action 07:05:38 INFO - Running main action method: download_and_extract 07:05:38 INFO - mkdir: /builds/slave/test/build/tests 07:05:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:38 INFO - trying https://queue.taskcluster.net/v1/task/D-pCWEEQSYmtHEo9I9KBdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:05:38 INFO - Downloading https://queue.taskcluster.net/v1/task/D-pCWEEQSYmtHEo9I9KBdw/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 07:05:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D-pCWEEQSYmtHEo9I9KBdw/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 07:05:39 INFO - Downloaded 1361 bytes. 07:05:39 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:05:39 INFO - Using the following test package requirements: 07:05:39 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:05:39 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:05:39 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:05:39 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:39 INFO - u'jsshell-linux-x86_64.zip'], 07:05:39 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:05:39 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:05:39 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:05:39 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:05:39 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:05:39 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:05:39 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:05:39 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:05:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:39 INFO - trying https://queue.taskcluster.net/v1/task/D-pCWEEQSYmtHEo9I9KBdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:05:39 INFO - Downloading https://queue.taskcluster.net/v1/task/D-pCWEEQSYmtHEo9I9KBdw/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 07:05:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D-pCWEEQSYmtHEo9I9KBdw/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 07:05:40 INFO - Downloaded 20315699 bytes. 07:05:40 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 07:05:44 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 07:05:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:44 INFO - trying https://queue.taskcluster.net/v1/task/D-pCWEEQSYmtHEo9I9KBdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:05:44 INFO - Downloading https://queue.taskcluster.net/v1/task/D-pCWEEQSYmtHEo9I9KBdw/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 07:05:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D-pCWEEQSYmtHEo9I9KBdw/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 07:05:45 INFO - Downloaded 20315699 bytes. 07:05:45 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 07:05:50 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')]} 07:05:50 INFO - trying https://queue.taskcluster.net/v1/task/D-pCWEEQSYmtHEo9I9KBdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:05:50 INFO - Downloading https://queue.taskcluster.net/v1/task/D-pCWEEQSYmtHEo9I9KBdw/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 07:05:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D-pCWEEQSYmtHEo9I9KBdw/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 07:05:51 INFO - Downloaded 14413719 bytes. 07:05:51 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 07:05:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:51 INFO - trying https://queue.taskcluster.net/v1/task/D-pCWEEQSYmtHEo9I9KBdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:05:51 INFO - Downloading https://queue.taskcluster.net/v1/task/D-pCWEEQSYmtHEo9I9KBdw/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 07:05:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D-pCWEEQSYmtHEo9I9KBdw/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 07:05:52 INFO - Downloaded 55771615 bytes. 07:05:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D-pCWEEQSYmtHEo9I9KBdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:05:52 INFO - mkdir: /builds/slave/test/properties 07:05:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:05:52 INFO - Writing to file /builds/slave/test/properties/build_url 07:05:52 INFO - Contents: 07:05:52 INFO - build_url:https://queue.taskcluster.net/v1/task/D-pCWEEQSYmtHEo9I9KBdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:05:53 INFO - Running post-action listener: _resource_record_post_action 07:05:53 INFO - Running post-action listener: set_extra_try_arguments 07:05:53 INFO - [mozharness: 2016-08-18 14:05:53.134603Z] Finished download-and-extract step (success) 07:05:53 INFO - [mozharness: 2016-08-18 14:05:53.134830Z] Running populate-webroot step. 07:05:53 INFO - Running pre-action listener: _resource_record_pre_action 07:05:53 INFO - Running main action method: populate_webroot 07:05:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:05:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:05:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:05:53 INFO - '--tppagecycles', 07:05:53 INFO - '7'], 07:05:53 INFO - 'tests': ['tsvgm']}}, 07:05:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:05:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:05:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:05:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:05:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:05:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:05:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:53 INFO - 'talos_options': ['--disable-e10s'], 07:05:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:05:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:05:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:53 INFO - 'talos_options': ['--disable-e10s'], 07:05:53 INFO - 'tests': ['damp', 'tps']}, 07:05:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:53 INFO - 'tests': ['damp', 'tps']}, 07:05:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:05:53 INFO - 'tests': ['dromaeo_dom']}, 07:05:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:05:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:05:53 INFO - 'tests': ['basic_compositor_video']}, 07:05:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:05:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:05:53 INFO - 'tests': ['a11yr', 07:05:53 INFO - 'ts_paint', 07:05:53 INFO - 'tpaint', 07:05:53 INFO - 'sessionrestore', 07:05:53 INFO - 'sessionrestore_no_auto_restore', 07:05:53 INFO - 'tabpaint']}, 07:05:53 INFO - 'other-e10s': {'tests': ['a11yr', 07:05:53 INFO - 'ts_paint', 07:05:53 INFO - 'tpaint', 07:05:53 INFO - 'sessionrestore', 07:05:53 INFO - 'sessionrestore_no_auto_restore', 07:05:53 INFO - 'tabpaint']}, 07:05:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:05:53 INFO - 'ts_paint', 07:05:53 INFO - 'tpaint', 07:05:53 INFO - 'sessionrestore', 07:05:53 INFO - 'sessionrestore_no_auto_restore', 07:05:53 INFO - 'tabpaint']}, 07:05:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:05:53 INFO - 'ts_paint', 07:05:53 INFO - 'tpaint', 07:05:53 INFO - 'sessionrestore', 07:05:53 INFO - 'sessionrestore_no_auto_restore', 07:05:53 INFO - 'tabpaint']}, 07:05:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:05:53 INFO - 'tests': ['a11yr', 07:05:53 INFO - 'ts_paint', 07:05:53 INFO - 'tpaint', 07:05:53 INFO - 'sessionrestore', 07:05:53 INFO - 'sessionrestore_no_auto_restore', 07:05:53 INFO - 'tabpaint']}, 07:05:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:05:53 INFO - 'tests': ['a11yr', 07:05:53 INFO - 'ts_paint', 07:05:53 INFO - 'tpaint', 07:05:53 INFO - 'sessionrestore', 07:05:53 INFO - 'sessionrestore_no_auto_restore', 07:05:53 INFO - 'tabpaint']}, 07:05:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:05:53 INFO - 'tests': ['tsvgx', 07:05:53 INFO - 'tsvgr_opacity', 07:05:53 INFO - 'tart', 07:05:53 INFO - 'tscrollx', 07:05:53 INFO - 'cart']}, 07:05:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:05:53 INFO - 'tsvgr_opacity', 07:05:53 INFO - 'tart', 07:05:53 INFO - 'tscrollx', 07:05:53 INFO - 'cart']}, 07:05:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:53 INFO - 'talos_options': ['--disable-e10s'], 07:05:53 INFO - 'tests': ['tp5o']}, 07:05:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:53 INFO - 'tests': ['tp5o']}, 07:05:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:53 INFO - 'talos_options': ['--disable-e10s', 07:05:53 INFO - '--xperf_path', 07:05:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:05:53 INFO - 'tests': ['tp5n']}, 07:05:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:05:53 INFO - 'talos_options': ['--xperf_path', 07:05:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:05:53 INFO - 'tests': ['tp5n']}}, 07:05:53 INFO - 'talos.zip': {'path': '', 07:05:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:05:53 INFO - Running post-action listener: _resource_record_post_action 07:05:53 INFO - [mozharness: 2016-08-18 14:05:53.154834Z] Finished populate-webroot step (success) 07:05:53 INFO - [mozharness: 2016-08-18 14:05:53.154921Z] Running create-virtualenv step. 07:05:53 INFO - Running pre-action listener: _resource_record_pre_action 07:05:53 INFO - Running main action method: create_virtualenv 07:05:53 INFO - Creating virtualenv /builds/slave/test/build/venv 07:05:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:05:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:05:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:05:53 INFO - Using real prefix '/usr' 07:05:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:05:53 INFO - Installing distribute.............................................................................................................................................................................................done. 07:05:55 INFO - Installing pip.................done. 07:05:55 INFO - Return code: 0 07:05:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:05: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')]} 07:05:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05: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')]} 07:05:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd74f822f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187e090>, '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 0x18819b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1881e40>, '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': '20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:05:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:05:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:05:55 INFO - Using env: {'DISPLAY': ':0', 07:05:55 INFO - 'HOME': '/home/cltbld', 07:05:55 INFO - 'LANG': 'en_US.UTF-8', 07:05:55 INFO - 'LANGUAGE': 'en_US:en', 07:05:55 INFO - 'LOGNAME': 'cltbld', 07:05:55 INFO - 'MAIL': '/var/mail/cltbld', 07:05:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:55 INFO - 'MOZ_NO_REMOTE': '1', 07:05:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:55 INFO - 'NO_EM_RESTART': '1', 07:05:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:55 INFO - 'PWD': '/builds/slave/test', 07:05:55 INFO - 'SHELL': '/bin/bash', 07:05:55 INFO - 'SHLVL': '1', 07:05:55 INFO - 'TERM': 'linux', 07:05:55 INFO - 'TMOUT': '86400', 07:05:55 INFO - 'USER': 'cltbld', 07:05:55 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601', 07:05:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:55 INFO - '_': '/tools/buildbot/bin/python'} 07:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:05:56 INFO - Cleaning up... 07:05:56 INFO - Return code: 0 07:05:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:05:56 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')]} 07:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:56 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')]} 07:05:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:56 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 0x7fd74f822f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187e090>, '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 0x18819b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1881e40>, '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': '20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:05:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:05:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:05:56 INFO - Using env: {'DISPLAY': ':0', 07:05:56 INFO - 'HOME': '/home/cltbld', 07:05:56 INFO - 'LANG': 'en_US.UTF-8', 07:05:56 INFO - 'LANGUAGE': 'en_US:en', 07:05:56 INFO - 'LOGNAME': 'cltbld', 07:05:56 INFO - 'MAIL': '/var/mail/cltbld', 07:05:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:56 INFO - 'MOZ_NO_REMOTE': '1', 07:05:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:56 INFO - 'NO_EM_RESTART': '1', 07:05:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:56 INFO - 'PWD': '/builds/slave/test', 07:05:56 INFO - 'SHELL': '/bin/bash', 07:05:56 INFO - 'SHLVL': '1', 07:05:56 INFO - 'TERM': 'linux', 07:05:56 INFO - 'TMOUT': '86400', 07:05:56 INFO - 'USER': 'cltbld', 07:05:56 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601', 07:05:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:56 INFO - '_': '/tools/buildbot/bin/python'} 07:05:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:05:56 INFO - Downloading/unpacking psutil>=3.1.1 07:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:05:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:05:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:05:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:05:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:05:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:05:58 INFO - Installing collected packages: psutil 07:05:58 INFO - Running setup.py install for psutil 07:05:58 INFO - building 'psutil._psutil_linux' extension 07:05:58 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:05:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:05:59 INFO - building 'psutil._psutil_posix' extension 07:05:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:05:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:05:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:05:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:05:59 INFO - Successfully installed psutil 07:05:59 INFO - Cleaning up... 07:05:59 INFO - Return code: 0 07:05:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:05:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:05:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:05:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:05:59 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 0x7fd74f822f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187e090>, '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 0x18819b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1881e40>, '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': '20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:05:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:05:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:05:59 INFO - Using env: {'DISPLAY': ':0', 07:05:59 INFO - 'HOME': '/home/cltbld', 07:05:59 INFO - 'LANG': 'en_US.UTF-8', 07:05:59 INFO - 'LANGUAGE': 'en_US:en', 07:05:59 INFO - 'LOGNAME': 'cltbld', 07:05:59 INFO - 'MAIL': '/var/mail/cltbld', 07:05:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:05:59 INFO - 'MOZ_NO_REMOTE': '1', 07:05:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:05:59 INFO - 'NO_EM_RESTART': '1', 07:05:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:05:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:05:59 INFO - 'PWD': '/builds/slave/test', 07:05:59 INFO - 'SHELL': '/bin/bash', 07:05:59 INFO - 'SHLVL': '1', 07:05:59 INFO - 'TERM': 'linux', 07:05:59 INFO - 'TMOUT': '86400', 07:05:59 INFO - 'USER': 'cltbld', 07:05:59 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601', 07:05:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:05:59 INFO - '_': '/tools/buildbot/bin/python'} 07:06:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:06:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:06:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:06:02 INFO - Installing collected packages: mozsystemmonitor 07:06:02 INFO - Running setup.py install for mozsystemmonitor 07:06:02 INFO - Successfully installed mozsystemmonitor 07:06:02 INFO - Cleaning up... 07:06:02 INFO - Return code: 0 07:06:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd74f822f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187e090>, '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 0x18819b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1881e40>, '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': '20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:06:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:06:02 INFO - Using env: {'DISPLAY': ':0', 07:06:02 INFO - 'HOME': '/home/cltbld', 07:06:02 INFO - 'LANG': 'en_US.UTF-8', 07:06:02 INFO - 'LANGUAGE': 'en_US:en', 07:06:02 INFO - 'LOGNAME': 'cltbld', 07:06:02 INFO - 'MAIL': '/var/mail/cltbld', 07:06:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:02 INFO - 'MOZ_NO_REMOTE': '1', 07:06:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:02 INFO - 'NO_EM_RESTART': '1', 07:06:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:02 INFO - 'PWD': '/builds/slave/test', 07:06:02 INFO - 'SHELL': '/bin/bash', 07:06:02 INFO - 'SHLVL': '1', 07:06:02 INFO - 'TERM': 'linux', 07:06:02 INFO - 'TMOUT': '86400', 07:06:02 INFO - 'USER': 'cltbld', 07:06:02 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601', 07:06:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:02 INFO - '_': '/tools/buildbot/bin/python'} 07:06:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:02 INFO - Downloading/unpacking jsonschema==2.5.1 07:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:06:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:04 INFO - Downloading functools32-3.2.3-2.tar.gz 07:06:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:06:04 INFO - warning: no files found matching '*.txt' 07:06:04 INFO - no previously-included directories found matching 'build' 07:06:04 INFO - no previously-included directories found matching 'dist' 07:06:04 INFO - no previously-included directories found matching '.git*' 07:06:04 INFO - Installing collected packages: jsonschema, functools32 07:06:04 INFO - Running setup.py install for functools32 07:06:04 INFO - warning: no files found matching '*.txt' 07:06:04 INFO - no previously-included directories found matching 'build' 07:06:04 INFO - no previously-included directories found matching 'dist' 07:06:04 INFO - no previously-included directories found matching '.git*' 07:06:04 INFO - Successfully installed jsonschema functools32 07:06:04 INFO - Cleaning up... 07:06:04 INFO - Return code: 0 07:06:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:04 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 0x7fd74f822f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187e090>, '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 0x18819b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1881e40>, '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': '20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:04 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 07:06:04 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 07:06:04 INFO - Using env: {'DISPLAY': ':0', 07:06:04 INFO - 'HOME': '/home/cltbld', 07:06:04 INFO - 'LANG': 'en_US.UTF-8', 07:06:04 INFO - 'LANGUAGE': 'en_US:en', 07:06:04 INFO - 'LOGNAME': 'cltbld', 07:06:04 INFO - 'MAIL': '/var/mail/cltbld', 07:06:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:04 INFO - 'MOZ_NO_REMOTE': '1', 07:06:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:04 INFO - 'NO_EM_RESTART': '1', 07:06:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:04 INFO - 'PWD': '/builds/slave/test', 07:06:04 INFO - 'SHELL': '/bin/bash', 07:06:04 INFO - 'SHLVL': '1', 07:06:04 INFO - 'TERM': 'linux', 07:06:04 INFO - 'TMOUT': '86400', 07:06:04 INFO - 'USER': 'cltbld', 07:06:04 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601', 07:06:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:04 INFO - '_': '/tools/buildbot/bin/python'} 07:06:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:06:05 INFO - Cleaning up... 07:06:05 INFO - Return code: 0 07:06:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fd74f822f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187e090>, '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 0x18819b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1881e40>, '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': '20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:06:05 INFO - Using env: {'DISPLAY': ':0', 07:06:05 INFO - 'HOME': '/home/cltbld', 07:06:05 INFO - 'LANG': 'en_US.UTF-8', 07:06:05 INFO - 'LANGUAGE': 'en_US:en', 07:06:05 INFO - 'LOGNAME': 'cltbld', 07:06:05 INFO - 'MAIL': '/var/mail/cltbld', 07:06:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:05 INFO - 'MOZ_NO_REMOTE': '1', 07:06:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:05 INFO - 'NO_EM_RESTART': '1', 07:06:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:05 INFO - 'PWD': '/builds/slave/test', 07:06:05 INFO - 'SHELL': '/bin/bash', 07:06:05 INFO - 'SHLVL': '1', 07:06:05 INFO - 'TERM': 'linux', 07:06:05 INFO - 'TMOUT': '86400', 07:06:05 INFO - 'USER': 'cltbld', 07:06:05 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601', 07:06:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:05 INFO - '_': '/tools/buildbot/bin/python'} 07:06:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:05 INFO - Downloading/unpacking blobuploader==1.2.4 07:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:07 INFO - Downloading blobuploader-1.2.4.tar.gz 07:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:06:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:06:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:07 INFO - Downloading docopt-0.6.1.tar.gz 07:06:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:06:07 INFO - Installing collected packages: blobuploader, requests, docopt 07:06:07 INFO - Running setup.py install for blobuploader 07:06:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:06:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:06:08 INFO - Running setup.py install for requests 07:06:08 INFO - Running setup.py install for docopt 07:06:08 INFO - Successfully installed blobuploader requests docopt 07:06:08 INFO - Cleaning up... 07:06:08 INFO - Return code: 0 07:06:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:08 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 0x7fd74f822f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187e090>, '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 0x18819b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1881e40>, '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': '20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:06:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:06:08 INFO - Using env: {'DISPLAY': ':0', 07:06:08 INFO - 'HOME': '/home/cltbld', 07:06:08 INFO - 'LANG': 'en_US.UTF-8', 07:06:08 INFO - 'LANGUAGE': 'en_US:en', 07:06:08 INFO - 'LOGNAME': 'cltbld', 07:06:08 INFO - 'MAIL': '/var/mail/cltbld', 07:06:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:08 INFO - 'MOZ_NO_REMOTE': '1', 07:06:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:08 INFO - 'NO_EM_RESTART': '1', 07:06:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:08 INFO - 'PWD': '/builds/slave/test', 07:06:08 INFO - 'SHELL': '/bin/bash', 07:06:08 INFO - 'SHLVL': '1', 07:06:08 INFO - 'TERM': 'linux', 07:06:08 INFO - 'TMOUT': '86400', 07:06:08 INFO - 'USER': 'cltbld', 07:06:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601', 07:06:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:08 INFO - '_': '/tools/buildbot/bin/python'} 07:06:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:08 INFO - Running setup.py (path:/tmp/pip-33zDPv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:08 INFO - Running setup.py (path:/tmp/pip-mrvBV1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:08 INFO - Running setup.py (path:/tmp/pip-yLXbf8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:08 INFO - Running setup.py (path:/tmp/pip-etOYs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:09 INFO - Running setup.py (path:/tmp/pip-iW1jkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:09 INFO - Running setup.py (path:/tmp/pip-KeJAo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:09 INFO - Running setup.py (path:/tmp/pip-Mj0rnz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:09 INFO - Running setup.py (path:/tmp/pip-z6_6wD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:09 INFO - Running setup.py (path:/tmp/pip-vnC8BQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:09 INFO - Running setup.py (path:/tmp/pip-WBo1jG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:09 INFO - Running setup.py (path:/tmp/pip-fL69a9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:09 INFO - Running setup.py (path:/tmp/pip-w447LT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:09 INFO - Running setup.py (path:/tmp/pip-yatT_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:09 INFO - Running setup.py (path:/tmp/pip-9sAELp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:09 INFO - Running setup.py (path:/tmp/pip-8V5R0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:09 INFO - Running setup.py (path:/tmp/pip-ZXCvOK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:09 INFO - Running setup.py (path:/tmp/pip-tunsgj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:06:09 INFO - Running setup.py install for manifestparser 07:06:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:06:10 INFO - Running setup.py install for mozcrash 07:06:10 INFO - Running setup.py install for mozdebug 07:06:10 INFO - Running setup.py install for mozdevice 07:06:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:06:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:06:10 INFO - Running setup.py install for mozfile 07:06:10 INFO - Running setup.py install for mozhttpd 07:06:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:06:10 INFO - Running setup.py install for mozinfo 07:06:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:06:10 INFO - Running setup.py install for mozInstall 07:06:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:06:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:06:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:06:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:06:10 INFO - Running setup.py install for mozleak 07:06:10 INFO - Running setup.py install for mozlog 07:06:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:06:10 INFO - Running setup.py install for moznetwork 07:06:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:06:11 INFO - Running setup.py install for mozprocess 07:06:11 INFO - Running setup.py install for mozprofile 07:06:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:06:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:06:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:06:11 INFO - Running setup.py install for mozrunner 07:06:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:06:11 INFO - Running setup.py install for mozscreenshot 07:06:11 INFO - Running setup.py install for moztest 07:06:11 INFO - Running setup.py install for mozversion 07:06:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:06:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:06:11 INFO - Cleaning up... 07:06:11 INFO - Return code: 0 07:06:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:11 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 0x7fd74f822f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187e090>, '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 0x18819b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1881e40>, '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': '20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:06:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:06:11 INFO - Using env: {'DISPLAY': ':0', 07:06:11 INFO - 'HOME': '/home/cltbld', 07:06:11 INFO - 'LANG': 'en_US.UTF-8', 07:06:11 INFO - 'LANGUAGE': 'en_US:en', 07:06:11 INFO - 'LOGNAME': 'cltbld', 07:06:11 INFO - 'MAIL': '/var/mail/cltbld', 07:06:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:11 INFO - 'MOZ_NO_REMOTE': '1', 07:06:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:11 INFO - 'NO_EM_RESTART': '1', 07:06:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:11 INFO - 'PWD': '/builds/slave/test', 07:06:11 INFO - 'SHELL': '/bin/bash', 07:06:11 INFO - 'SHLVL': '1', 07:06:11 INFO - 'TERM': 'linux', 07:06:11 INFO - 'TMOUT': '86400', 07:06:11 INFO - 'USER': 'cltbld', 07:06:11 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601', 07:06:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:11 INFO - '_': '/tools/buildbot/bin/python'} 07:06:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:06:11 INFO - Running setup.py (path:/tmp/pip-ZHoDEJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:06:12 INFO - Running setup.py (path:/tmp/pip-faHh1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:06:12 INFO - Running setup.py (path:/tmp/pip-Ierk_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:06:12 INFO - Running setup.py (path:/tmp/pip-efd1Ox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:06:12 INFO - Running setup.py (path:/tmp/pip-u9cEIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:06:12 INFO - Running setup.py (path:/tmp/pip-0lD3_u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:06:12 INFO - Running setup.py (path:/tmp/pip-WKPt3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:06:12 INFO - Running setup.py (path:/tmp/pip-Qskikt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:06:12 INFO - Running setup.py (path:/tmp/pip-f5JjWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:06:12 INFO - Running setup.py (path:/tmp/pip-_7Zi53-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:06:12 INFO - Running setup.py (path:/tmp/pip-vSHoJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:06:12 INFO - Running setup.py (path:/tmp/pip-fqFRHL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:06:12 INFO - Running setup.py (path:/tmp/pip-Ods1a1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:06:12 INFO - Running setup.py (path:/tmp/pip-6mXEAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:06:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:06:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:12 INFO - Running setup.py (path:/tmp/pip-IY_qhi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:06:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:06:13 INFO - Running setup.py (path:/tmp/pip-zKQoBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:06:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:06:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:06:13 INFO - Running setup.py (path:/tmp/pip-s3gn0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:06:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:06:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:06:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:06:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:06:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:06:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:06:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:06:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:06:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:06:15 INFO - Downloading blessings-1.6.tar.gz 07:06:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:06:15 INFO - Installing collected packages: blessings 07:06:15 INFO - Running setup.py install for blessings 07:06:15 INFO - Successfully installed blessings 07:06:15 INFO - Cleaning up... 07:06:15 INFO - Return code: 0 07:06:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:06:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:15 INFO - Reading from file tmpfile_stdout 07:06:15 INFO - Current package versions: 07:06:15 INFO - argparse == 1.2.1 07:06:15 INFO - blessings == 1.6 07:06:15 INFO - blobuploader == 1.2.4 07:06:15 INFO - docopt == 0.6.1 07:06:15 INFO - functools32 == 3.2.3-2 07:06:15 INFO - jsonschema == 2.5.1 07:06:15 INFO - manifestparser == 1.1 07:06:15 INFO - mozInstall == 1.12 07:06:15 INFO - mozcrash == 0.17 07:06:15 INFO - mozdebug == 0.1 07:06:15 INFO - mozdevice == 0.48 07:06:15 INFO - mozfile == 1.2 07:06:15 INFO - mozhttpd == 0.7 07:06:15 INFO - mozinfo == 0.9 07:06:15 INFO - mozleak == 0.1 07:06:15 INFO - mozlog == 3.3 07:06:15 INFO - moznetwork == 0.27 07:06:15 INFO - mozprocess == 0.23 07:06:15 INFO - mozprofile == 0.28 07:06:15 INFO - mozrunner == 6.12 07:06:15 INFO - mozscreenshot == 0.1 07:06:15 INFO - mozsystemmonitor == 0.3 07:06:15 INFO - moztest == 0.7 07:06:15 INFO - mozversion == 1.4 07:06:15 INFO - psutil == 3.1.1 07:06:15 INFO - requests == 1.2.3 07:06:15 INFO - wsgiref == 0.1.2 07:06:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:06: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')]} 07:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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')]} 07:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06:15 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 0x7fd74f822f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187e090>, '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 0x18819b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1881e40>, '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': '20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:06:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:06:15 INFO - Using env: {'DISPLAY': ':0', 07:06:15 INFO - 'HOME': '/home/cltbld', 07:06:15 INFO - 'LANG': 'en_US.UTF-8', 07:06:15 INFO - 'LANGUAGE': 'en_US:en', 07:06:15 INFO - 'LOGNAME': 'cltbld', 07:06:15 INFO - 'MAIL': '/var/mail/cltbld', 07:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:15 INFO - 'MOZ_NO_REMOTE': '1', 07:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:15 INFO - 'NO_EM_RESTART': '1', 07:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:15 INFO - 'PWD': '/builds/slave/test', 07:06:15 INFO - 'SHELL': '/bin/bash', 07:06:15 INFO - 'SHLVL': '1', 07:06:15 INFO - 'TERM': 'linux', 07:06:15 INFO - 'TMOUT': '86400', 07:06:15 INFO - 'USER': 'cltbld', 07:06:15 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601', 07:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:15 INFO - '_': '/tools/buildbot/bin/python'} 07:06:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:06:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:06:15 INFO - Cleaning up... 07:06:15 INFO - Return code: 0 07:06:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:06: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')]} 07:06:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:06:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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')]} 07:06:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:06:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:06: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd74f822f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1884230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x187e090>, '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 0x18819b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1881e40>, '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': '20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:06: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', 'jsonschema'] in /builds/slave/test/build 07:06: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 jsonschema 07:06:15 INFO - Using env: {'DISPLAY': ':0', 07:06:15 INFO - 'HOME': '/home/cltbld', 07:06:15 INFO - 'LANG': 'en_US.UTF-8', 07:06:15 INFO - 'LANGUAGE': 'en_US:en', 07:06:15 INFO - 'LOGNAME': 'cltbld', 07:06:15 INFO - 'MAIL': '/var/mail/cltbld', 07:06:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:15 INFO - 'MOZ_NO_REMOTE': '1', 07:06:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:15 INFO - 'NO_EM_RESTART': '1', 07:06:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:15 INFO - 'PWD': '/builds/slave/test', 07:06:15 INFO - 'SHELL': '/bin/bash', 07:06:15 INFO - 'SHLVL': '1', 07:06:15 INFO - 'TERM': 'linux', 07:06:15 INFO - 'TMOUT': '86400', 07:06:15 INFO - 'USER': 'cltbld', 07:06:15 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601', 07:06:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:15 INFO - '_': '/tools/buildbot/bin/python'} 07:06:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:06:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:06:16 INFO - Cleaning up... 07:06:16 INFO - Return code: 0 07:06:16 INFO - Running post-action listener: _resource_record_post_action 07:06:16 INFO - Running post-action listener: _start_resource_monitoring 07:06:16 INFO - Starting resource monitoring. 07:06:16 INFO - [mozharness: 2016-08-18 14:06:16.047626Z] Finished create-virtualenv step (success) 07:06:16 INFO - [mozharness: 2016-08-18 14:06:16.048612Z] Running install step. 07:06:16 INFO - Running pre-action listener: _resource_record_pre_action 07:06:16 INFO - Running main action method: install 07:06:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:06:16 INFO - Reading from file tmpfile_stdout 07:06:16 INFO - Detecting whether we're running mozinstall >=1.0... 07:06:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:06:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:06:16 INFO - Reading from file tmpfile_stdout 07:06:16 INFO - Output received: 07:06:16 INFO - Usage: mozinstall [options] installer 07:06:16 INFO - Options: 07:06:16 INFO - -h, --help show this help message and exit 07:06:16 INFO - -d DEST, --destination=DEST 07:06:16 INFO - Directory to install application into. [default: 07:06:16 INFO - "/builds/slave/test"] 07:06:16 INFO - --app=APP Application being installed. [default: firefox] 07:06:16 INFO - mkdir: /builds/slave/test/build/application 07:06:16 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'] 07:06:16 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 07:06:32 INFO - Reading from file tmpfile_stdout 07:06:32 INFO - Output received: 07:06:32 INFO - /builds/slave/test/build/application/firefox/firefox 07:06:32 INFO - Running post-action listener: _resource_record_post_action 07:06:32 INFO - [mozharness: 2016-08-18 14:06:32.431752Z] Finished install step (success) 07:06:32 INFO - [mozharness: 2016-08-18 14:06:32.432001Z] Running run-tests step. 07:06:32 INFO - Running pre-action listener: _resource_record_pre_action 07:06:32 INFO - Running main action method: run_tests 07:06:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:06:32 INFO - Python 2.7.3 07:06:32 INFO - Return code: 0 07:06:32 INFO - grabbing minidump binary from tooltool 07:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:06:32 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 0x187e090>, '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 0x18819b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1881e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:06:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:06:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:06:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:06:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:06:32 INFO - Return code: 0 07:06:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:06:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:06:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:06:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:06:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:06:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D-pCWEEQSYmtHEo9I9KBdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:06:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/D-pCWEEQSYmtHEo9I9KBdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:06:32 INFO - Using env: {'DISPLAY': ':0', 07:06:32 INFO - 'HOME': '/home/cltbld', 07:06:32 INFO - 'LANG': 'en_US.UTF-8', 07:06:32 INFO - 'LANGUAGE': 'en_US:en', 07:06:32 INFO - 'LOGNAME': 'cltbld', 07:06:32 INFO - 'MAIL': '/var/mail/cltbld', 07:06:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:06:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:06:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:06:32 INFO - 'MOZ_NO_REMOTE': '1', 07:06:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:06:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:06:32 INFO - 'NO_EM_RESTART': '1', 07:06:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:06:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:06:32 INFO - 'PWD': '/builds/slave/test', 07:06:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:06:32 INFO - 'SHELL': '/bin/bash', 07:06:32 INFO - 'SHLVL': '1', 07:06:32 INFO - 'TERM': 'linux', 07:06:32 INFO - 'TMOUT': '86400', 07:06:32 INFO - 'USER': 'cltbld', 07:06:32 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601', 07:06:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:06:32 INFO - '_': '/tools/buildbot/bin/python'} 07:06:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/D-pCWEEQSYmtHEo9I9KBdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:06:32 INFO - mozversion application_buildid: 20160816222215 07:06:32 INFO - mozversion application_changeset: 5b442b4e42c3a3a5a8b29746e4639eec4707c913 07:06:32 INFO - mozversion application_display_name: Nightly 07:06:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:06:32 INFO - mozversion application_name: Firefox 07:06:32 INFO - mozversion application_remotingname: firefox 07:06:32 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 07:06:32 INFO - mozversion application_vendor: Mozilla 07:06:32 INFO - mozversion application_version: 51.0a1 07:06:32 INFO - mozversion platform_buildid: 20160816222215 07:06:32 INFO - mozversion platform_changeset: 5b442b4e42c3a3a5a8b29746e4639eec4707c913 07:06:32 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 07:06:32 INFO - mozversion platform_version: 51.0a1 07:06:32 INFO - using testdate: 1471529192 07:06:32 INFO - actual date: 1471529192 07:06:32 INFO - starting webserver on 'localhost:58819' 07:06:32 INFO - SUITE-START | Running 2 tests 07:06:32 INFO - TEST-START | dromaeo_css 07:06:32 INFO - operating with platform_type : linux_ 07:06:32 INFO - Initialising browser for dromaeo_css test... 07:06:32 INFO - TEST-INFO | started process 3312 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgf0jtn/profile http://localhost:58819/getInfo.html) 07:06:38 INFO - PROCESS | 3312 | __metrics Screen width/height:1600/1200 07:06:38 INFO - PROCESS | 3312 | colorDepth:24 07:06:38 INFO - PROCESS | 3312 | Browser inner width/height: 1024/697 07:06:38 INFO - PROCESS | 3312 | __metrics 07:06:38 INFO - PROCESS | 3312 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:06:38 INFO - PROCESS | 3312 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:06:39 INFO - PROCESS | 3312 | console.error: PushService: 07:06:39 INFO - PROCESS | 3312 | stateChangeProcessEnqueue: Error transitioning state 07:06:39 INFO - PROCESS | 3312 | UnknownError 07:06:39 INFO - TEST-INFO | 3312: exit 0 07:06:39 INFO - Browser initialized. 07:06:39 INFO - Running cycle 1/1 for dromaeo_css test... 07:06:39 INFO - TEST-INFO | started process 3396 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgf0jtn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:06:51 INFO - PROCESS | 3396 | RSS: Main: 157224960 07:06:51 INFO - PROCESS | 3396 | 07:07:43 INFO - PROCESS | 3396 | 1471529263088 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:09:56 INFO - PROCESS | 3396 | Cycle 1(1): loaded http://localhost:58819/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58819/tests/dromaeo/cssquery-ext.html) 07:09:57 INFO - PROCESS | 3396 | RSS: Main: 248078336 07:09:57 INFO - PROCESS | 3396 | 07:13:00 INFO - PROCESS | 3396 | Cycle 1(1): loaded http://localhost:58819/tests/dromaeo/cssquery-ext.html (next: http://localhost:58819/tests/dromaeo/cssquery-jquery.html) 07:13:00 INFO - PROCESS | 3396 | RSS: Main: 250146816 07:13:00 INFO - PROCESS | 3396 | 07:16:03 INFO - PROCESS | 3396 | Cycle 1(1): loaded http://localhost:58819/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58819/tests/dromaeo/cssquery-mootools.html) 07:16:03 INFO - PROCESS | 3396 | RSS: Main: 218402816 07:16:03 INFO - PROCESS | 3396 | 07:19:06 INFO - PROCESS | 3396 | Cycle 1(1): loaded http://localhost:58819/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58819/tests/dromaeo/cssquery-prototype.html) 07:19:06 INFO - PROCESS | 3396 | RSS: Main: 224952320 07:19:06 INFO - PROCESS | 3396 | 07:22:09 INFO - PROCESS | 3396 | Cycle 1(1): loaded http://localhost:58819/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58819/tests/dromaeo/cssquery-yui.html) 07:22:10 INFO - PROCESS | 3396 | RSS: Main: 189366272 07:22:10 INFO - PROCESS | 3396 | 07:25:13 INFO - PROCESS | 3396 | Cycle 1(1): loaded http://localhost:58819/tests/dromaeo/cssquery-yui.html (next: http://localhost:58819/tests/dromaeo/cssquery-dojo.html) 07:25:14 INFO - PROCESS | 3396 | RSS: Main: 267489280 07:25:14 INFO - PROCESS | 3396 | 07:25:14 INFO - PROCESS | 3396 | __start_tp_report 07:25:14 INFO - PROCESS | 3396 | _x_x_mozilla_page_load 07:25:14 INFO - PROCESS | 3396 | _x_x_mozilla_page_load_details 07:25:14 INFO - PROCESS | 3396 | |i|pagename|runs| 07:25:14 INFO - PROCESS | 3396 | |0;dojo.html;2580.832245904016;2588.0424243030084;2595.4809038192366;2622.947541049179;2624.147152175542;4538.954610453894;4589.977050114745;4661;4691.483936766957;4709.929351059733;4585.2663573828195;4587.88530286743;4613.561711637398;4620.145273124474;4623.653226008046;4166.208420400129;4190.790460476979;4231;4274.658027357804;4380.824767009316;4355.673324500659;4364.214441400547;4373.978130109345;4384.605385515303;4404.955950440487;4139.441175441307;4152.667786577097;4166.625003749647;4312.719673221262;4324.610785029363;4199.370094485821;4211.305134652778;4228.936565951513;4257.084726783756;4277.2942464493635;4226.091390351058;4271.508776490681;4282.593153650399;4282.957170428318;4318.892027699301;4530.8867278317975;4672.813087476497;4676.625869930432;4678.064387122589;4682.508336624674;4903.779329930162;4931.876703082416;4942.505749425065;5022.824201152978;5028.421731500887;4983.227599722049;4989.800407983676;5024.32171656829;5028.522290382444;5042.697438153723;4508.639308855284;4594.035252596992;4693.718376897363;4701.036287561042;4707.03505781314;5081.59347252219;5123.436421993578;5136.178211486144;5154.484551544815;5158.174692049254;4903.41159060915;4931.728754918442;4953.578945789648;4953.6532442729385;4954.777035033432;4846.5638092571835;4932.704037757746;5042.067217564689;5042.6470147090085;5054.090263752486;4935.3090567320605;4966.404031516241;4976.552110310089;4996.175631020914;5008.6744361616375;4946.554810067111;4954.182559877652;4966.279889416014;4971.850844474671;4987.800487980513;4111.075008123208;4153.27317719404;4206.516250631216;4218.6835987300465;4249.745015299092;3661.8718344857803;3680.0799800049986;3686.9631303687156;3728.5712143103347;3783.7162212834146;4337.1976184405985;4341.565843415633;4371.978140109279;4381.38660587518;4388.319810429389;4936.555709986119;5030.346055012825;5038.5969122470115;5041.395032596112;5047.29337892688;4245.532991370947;4288.035192081757;4288.356746488052;4300.591443812833;4336.804843782037;4465.330200469955;4491.371208030879;4495.033567782943;4498.460184777782;4542.704724192917;4579.038401935631;4705.106029854317;4713.057388522309;4717.882052948704;4726.125666751662;4926.58124059459;4929.285253638274;4965.30485732005;5000.049990501793;5039.974800125976;4675.579197872208;4682.063587282489;4703;4708.199606066908;4750.572448479654;4827.734474603931;4885.364902562644;4893.951060489492;4895.290182923527;4936.802527898843;4964.081644895706;4984.7258400788305;5019.62352823547;5020.146575082318;5037.0681423936685;4857.95142048575;4864.100141473838;4864.781084851119;4865.63619490483;4910.189818679878;4727.692699974491;4866.29438731389;4866.7079975201605;4878.292647566154;4918.163912135017;4779.713217206979;4790.425148982005;4808.951910480991;4813.253945638432;4876.073546026244;4934.925976110289;4936.654434189572;4938.678985865908;4947.158982972831;4986.975065124651;4668.5564871337165;4820.39745031871;4823.589994850477;4826.758662066953;4870 07:25:14 INFO - PROCESS | 3396 | |1;ext.html;562.6905202138823;566.4222493057084;574.6264927796929;579.8724280658254;581.6248519704791;29026.41947161058;39389.60610393895;40702.38946415803;40829.18341633165;43999.12001759971;40918.38622420666;41346.10577259593;41354.79322603383;41378.58621413785;41388;7412.073490813648;7698.114716807569;7841.05907291123;7845.254700803414;7847.372210223169;7439.404847612178;7683.961580192091;7690.807729806744;9875.851862222073;10114.2414318926;10197.847032294521;10241.84637230442;10245.743856403613;10252.538635761408;10271.28101032928;10091.444970526618;10094.697159085239;10134.189264858793;10152.984701529862;10163.847542286872;10058.647947321882;10129.088382045651;10131.949340253324;10132.290739648228;10133.594656213743;38757.22485550273;39068;39100.60899391027;39112.60887391118;39136.41295380572;2986.089242780951;3029.3184033592484;3046.6953304669355;3073.462144124769;3106.502959526465;28849.278768030967;29578.112656620335;29906.252343691365;30027.849860750557;30483.542746858813;3453.2748122894222;3468.4486097970725;3509.7192224621967;3535.8585656573705;3561.94657080144;251178;251188;251769;252028;252785;53530.464695352544;53879;53886;53886.7305663477;53969.73015134978;32313.35373292568;33234.50148247778;33325.16687082842;35181.29637407237;35242.29515409678;14309.28453577317;14546.4908728194;14548.345324460424;14554.636134096521;14596.56210313671;10937.289076210021;10996.395198264172;11039.061679757311;11121.888781112086;11191.776164476665;15966.323536028782;16256.67486650284;16311.553267009805;16982.320707171573;17793.644127117386;6680.565763225375;7010.649467526603;7027.754028608974;7094.467914906402;7143.107111611049;728.992710072903;843.5613480989973;855.7090589199702;897.528797381367;957.3203025851724;26568.468630627278;28059.859700701367;28126;28793.568096478568;28853.7114628851;900.1178844732199;901.6123067081218;935.7529373075417;951.3863558005048;958.6069711418425;14168.291585420893;14928.552143435714;15240.161791101596;15409.306581203873;15564.688706225812;385329;387668;388027;388142;388519;50463.747681262095;50597.49402506001;50873.74563127161;50956;50990.49009509932;1140.7376303450253;1160.0313738028672;1164.3130552973616;1167.200467679642;1182.1370399608163;25915.611265831405;27074.864625677532;27620.309492262855;27835.860820695765;28423;43307.35038974355;43661.78169109134;43679.12641747211;43716.56283437125;43810.342844856714;318995;320362;321900;323827;324542;22368.440788980406;24486.632700509865;25281;25284.49431011333;25933.740662593133;41315.7934210327;41746.37380439357;42766.786166068974;42816.57183428126;42954.140917180855;35915;36308.45537316995;36439.81780091082;37573.81213093917;38161.80919095498;36837.81581092185;37074.6292537082;37369.719150289704;37486.62513374831;37807.43288850615;35916.28167436689;36384.63615363812;37234.06914827151;37242.8137859309;37388;31937.840310798296;33396.833015835735;33853;34387.15418378932;34569.82715086408;25175;25258.747412526376;25372.238832835046;25447.182922561762;25944.740552594234 07:25:14 INFO - PROCESS | 3396 | |2;jquery.html;354.5373287859343;368.10550362618824;371.20561997325746;375.283209070675;391.5458068640378;12807.743845123103;13222.53721119761;15574.364691707364;16999.23503442345;17052.48842534726;15111.168885711282;15401.922990385032;15418.537443876674;15614.76577851333;16327.59181020475;4799.760011999395;4964.851054468371;4971.055499455092;4971.304017437562;4990.500949905017;3265.7060864522186;5592.3009623797025;5815;5873.353931067601;5969.462748352647;5633.070543360361;5907.556933230004;5907.556933230004;5914.674692891911;5921.052631578948;5803.883922321551;5829.562782791287;5858.326292476378;5893.410658934073;5896.705164741746;4714.669973101884;4972.8508144755715;5177.301064356301;5204.219367094928;5206.297149884755;12451.688707782287;12546.435410406553;12591.559295424617;12670.873291267062;15118.622034449118;1783.3312507809571;1837.660032893919;1884.67960446723;1915.2721965652963;1931.652302585534;9028.729138125802;9087.000429952699;9607.56765945534;9713.417194968253;13323.467061317633;1606.7911171547742;1659.7095508286122;1703.2505697493186;1720.5268551148533;1739.226044410238;65191.674041629965;69554.65222673854;70189.29810701878;70973.29026709718;71189.2881071193;9882.160016398542;10064.597416103274;10147.847782283272;10156.746081348025;10192.541335639915;13384.397702103428;13545.593632190852;13555.118917270544;13567.932160339134;13668.589942301747;6733.595984240961;6854.554453960576;6885.173779146434;7018.894716579255;7377.0409846719585;6791.252962174157;6844.486663500257;6877.89683154753;7025.402840758593;7033.226345102034;4189.287821070426;4238.915221695611;4282.735469114349;4294.441722576045;4358.760268185217;1754.2106052276526;1788.9821101788816;1803.603207294393;1806.6115785106265;1827.7532533108126;757.7310054930531;784.2510402565537;831.476170012888;835.1439774231461;861.3755027604936;16359.91820040916;16397.180140992903;16611;16843.578910527336;17385.56536086608;798.66456088443;839.9454035487673;866.7183165471247;868.6568805321989;910.2854259406334;9155.954220228856;9169.449833010041;9590.472524011246;9594.376365536218;9601.855972160423;393041;401371;405555;409404;414480;76472.23527764651;77596;78605.60697196478;79029.60485197652;79878.6006069966;912.2428384440898;932.7155217658543;951.4481600671594;957.3155194036158;959.1990687775785;14359.210243436712;14428.350724217225;14542.200178990257;14714.63213419673;15204.163770992702;34903.30193396169;35456.64543354533;36003;36203.45694814527;39606;47706.761466192445;51430.74284628553;51488.742556286976;51793;53599.19601206063;7023.613701246481;7437.888431673638;7465.477416580788;7514.173440921603;7657.770266892002;9972.650957216463;11334.263272887236;11401.942990284995;11616.651500455;11827.645170644895;9300.953495232481;9712.125908668253;9768.511574421393;9771.804563908825;10376.688699339033;9841.45871977048;9941.155001824925;10024.448655324028;10187.235957303084;10292.639757608447;9700.563474643517;9906.801863962824;9966.50167491637;10283.228757843042;10287.177025838064;7142.5000249982;7166.211716711054;7363.263673632594;7645.541267523967;7760.18518055596;7822.413319000984;9640.469774162488;10047.346922450017;10111.544980476043;10247.487625618838 07:25:14 INFO - PROCESS | 3396 | |3;mootools.html;1191.4459776204073;1318.8878945289646;1382.7511048011356;1431.685029293555;1665.3671604790177;6827.897581536275;7717.652705628247;8046;8058.476199047065;8294.170582941702;8125.471844330114;8194.91805081949;8197.262246397822;8199.549024803633;8201.384896132799;2121.596896589647;2124.8725076495384;2141.3468891987936;2144.6246906791325;2149.0866381787755;2099.128861522466;2135.797099275574;2144.5496445746335;2159.773223811501;2170.6743988401786;2180.9672854907108;2187.3656639574583;2196.4728465168323;2201.361605134509;2245.977540224593;2095.685647152939;2096.9895150524226;2102.3482720356737;2103.9263625773024;2104.8737075775502;2093.089506064867;2143.9035243414082;2144.07804644003;2147.795959383856;2151.193302511558;7837.843243135162;8041.276285134366;8104.351651867836;8107.837843243161;8134.837303253961;4526.456825180966;4699.765011749399;4722.834700785456;4724.220503616899;4724.929126063112;2852.7289907458758;2975.895843645462;2998.1155559110116;3003.8798448062053;3005.9098227053223;974.6101559376235;993.5727637116037;996.8305388084043;1022.6676330192718;1040.3393844908462;11135.498902549405;11226.270292431047;11248.381339026431;11248.493817778219;11291.548338066468;4102.917941641151;4368.27923392643;4504.684672072924;4548.067646132535;4594.1271158479785;8891.19979201875;8964.14840590143;8981.550922453851;8985.415947963362;8989.955050224838;4531.116432295737;4531.614812740954;4534.886627834265;4536.070105628338;4538.636909047268;3298.640955996852;3686.0416291764336;4197.790110494524;4222.852200172979;4390.8024138913825;3376.74674399421;3384.5769278840144;3454.516367708523;3458;3489.1102768793794;992.1318846009741;992.533509250651;1001.0590045357341;1015.7409860485529;1016.1718199667396;596.9641821490725;741.6440108747831;795.681727309081;850.9531975741394;868.8740132680853;5330.626856120112;5368.677879327252;5483.369412517612;5520.861978450571;5696.287964004499;433.87417648882104;443.51213664968276;445.5143893156475;449.12196655538344;604.4620287943734;3493.4934434506854;3655.451682247684;3729.0863738383728;3744.8689295874515;3814.5422549294262;9651.469169195761;10145.543450544596;10171.949140254252;10188.286819922534;10198.490075496196;10086.29395942277;10113.898861011443;10121.1903047756;10122.443265620313;10127.341722787995;7421.777346679608;7456.664450099758;7627.8855817162785;7633.358827852038;7648.196939321514;5342.78628854857;5361.678299302054;5405.324334458192;5415.1335786274;5616.21373007771;9210.677626283048;9269.67556135532;9330.860037099585;9349.39228950116;9433;8064.274215320649;8143.02283725933;9135.680251191443;9435;9480.288978326791;6251.4061164189325;6497.642629655415;6501.414872661483;6501.8699626008165;6536.444402225674;7608.695652173851;7619;7670.7315243966195;7675.850761786709;7692;6507.349265073455;6565.704543295467;6577.638229897401;6599.340065993362;6600.372964568358;6600.372964568358;6627.4698024158915;6662.700178491883;6676.265610782907;6742.9662851685425;6425.839354016187;6468.967655161882;6479.546431749733;6488.156539650005;6519.771807986887;4645.814167433265;4791.808327666854;4793.472718001087;4807;4826.86045588119;4610.423697037871;4652.441706995182;4722.480527141943;4861.270809378621;4889.853304400874 07:25:14 INFO - PROCESS | 3396 | |4;prototype.html;302.23232988209946;307.12775716963824;314.9212696825794;315.37398264445085;316.98256595887216;4540.250858608326;4642.8839279018;4669.509701481346;4709.788059537321;4719.929201061983;4524.411826462555;4632.768361581924;4655.837045703401;4665.4168228971375;4671.243966060024;3716.1267102230954;3733.9626603733886;3741.7006639468914;3742.270257299828;3747.5502939647213;3558.34170678424;3749.1939233064886;3753.1555400035045;3758;3761;3494.8077855717925;3676.0809797550614;3700.9259814803686;3719.460678201659;3720.2931443025736;3688.723345749053;3689.465027571014;3708.091517578197;3708.2583483303447;3717.587316819605;3293.901182964491;3295.2915123248376;3297.38998285318;3300.1254667513126;3301.5377847101427;4458.1306645204195;4578.198815207325;4578.908421831578;4615.676902616819;4615.792289346954;4247.469066366704;4253.702240843142;4259.76571288579;4259.91480170398;4263.829446822124;4924.433690125646;4938.2839488274;4946.752662366867;4960.2559616057515;4964;3363.445031569788;3506.50908872758;3533.964660353415;3543.326767914088;3625.5649322081517;5093.567046801027;5118.181091025455;5122.462141475166;5133.563647090002;5138.482143749536;3611.476335931275;3617.6382361763613;3621.511096002006;3628.1836586767768;3628.9818550907075;3458.544433452277;3662.597114317423;3675.503806986076;3677.3196958562753;3682.447632855093;4144.91710165795;4160.750354978711;4169.395437661522;4175.5824417558;4176.206520761046;4927.384076990376;4933.309336692866;4938.037177693427;4946.727929963887;4950.5544500994365;1198.6943329451108;1214.4352875912743;1254.4166962362362;1265.3862876504888;1266.8661547914749;859.4155973937783;877.8814859993947;878.1295839861056;882.2368651116738;882.6337070115958;4325.9134817303475;4344.674149438804;4345.435093437833;4353.673474489426;4367.497737760134;5016.698998060128;5022.84931452057;5040.924386134211;5046.84859454217;5064.569511591556;4208.305629571148;4354.303311470149;4408.228560002051;4423.535528769433;4451.399061126771;2676.892924283007;2694.0871980893785;2697.7572018518426;2701.2571542825485;2706.282835048714;4809.374781278411;4831.830885918976;4834.419869615598;4851.51484851512;4857.295692124622;5057.6459647824295;5142.9742851286255;5212.4266330703595;5215.217717342429;5249.456616783656;4820.71075735457;4821.421429428491;4829.1307564638;4833.4441539222735;4833.4441539223435;5039.84880453587;5060;5064.290999260033;5064.772085256246;5098.903735696843;4771.379720636295;5006.048850718352;5007.974960125176;5012.423571289202;5017.122003649274;4817.5182481752945;4820.469748327611;4826.276058591239;4829.372181616367;4846.909445374903;3602.729795265313;3606.3328284267495;3613.0786649404236;3618.3306088373733;3622.3117607654463;4830.203016502238;5056.469070747518;5074.695518268915;5081.72050537224;5116.769745361393;4927.581155601671;4951.826686066114;4956.950430495649;4957.479464656303;4963.528464795839;4953.331300274417;4957.553820156203;4960.578350840219;4961.5534601886;4968.503149685002;4652.441706995182;4682.297655351725;4773;4895.265710143364;4897.779599917941;4849.466558678613;4913;4964.950350496449;4983.825566105169;4991.6006719463085;4876.78054487556;4886.29148773433;4895.143349913679;4896.730679812645;4897.069556784199 07:25:14 INFO - PROCESS | 3396 | |5;yui.html;604.2926645032724;660.3792435110998;679.6160169504227;683.4942142814317;684.9691763870628;12342.629721108358;13115.803262951064;13228.735425291501;13241.735165296688;13260;12228.694282642939;12311.507539698401;12351.50593976242;12359.876401235984;12371.19587226832;627.3130921640796;747.4356860570261;754.0348354106738;773.5397438524069;775.9146493885668;759.7644730133649;772.1814876231213;777.4324742937631;777.5334799120538;777.5839925639784;795.3358945280669;796.5857753967933;797.2704974947916;797.3939805747644;798.7563793043148;655.354475841296;665.4044630056072;790.2137373313561;790.8299715561153;790.9723159689383;493.0853267189384;493.1468559392271;570.3070769015625;581.1718301420501;583.4573846322918;11938.164328496921;11986.580469683518;11990.16068875179;11993.64019079429;11999.340036298001;11105.444727763579;11771.7057073573;11895.46470408825;12129.21160124589;12339.136260461772;8769.649214031431;8897.466152030898;11373.601923932623;11469.827952580717;11722.179447438682;4066.146109317047;4077.8980525486804;4163.646090082347;4170.874873753762;4324.502682191525;60932.39067609311;61133.69433152806;61954.69022654903;62887.371126288606;63330.36669633245;9988.101070903653;10056.396616203052;10094.293399462114;10133.898661013443;10246.846297305547;18613.906930465262;18615.348462803737;18623.627527449375;18644.974526400907;18648;6639.900401493981;6778.694958726869;6821.283765204582;6929.861402771916;7011.474139439562;3680.9631903681156;3781.8487260509823;3834.6548810606623;3838.1364193056897;3873.496445462128;2863.5847802068583;2985.850707464618;2994.82031078136;2999.9100026999226;2999.9400011999637;499.5404228110075;509.28699820251944;514.3673281863254;526.7497938479191;548.6735392441491;513.8355726167665;565.8557067947647;572.6249306704116;581.8370856160282;588.5938702295488;7283.308085731847;7468.477206595486;7574.204708505637;7800.102988156321;7867.921320786719;494.6611571073826;541.4017510650752;598.6527813867946;619.8316174012019;621.8476473263988;3444.6383129771516;3551.5205447264807;3648.087978005499;3660.377735784923;3807.1433927366675;106690;109132;109520.45239773909;113221.43389283166;113628.43185784019;92543;93463.53268233615;94415;95193.5240323794;98346.50826745821;63627;63877.36122638714;64302.67848660727;69078;72596.63701681458;7710.683345558237;8329.83340333202;8431.072582016095;8448.112948140602;8854.690085846965;44554.55445445504;45791.31313030374;47204.52795472139;48049.75975120102;48221;67396.6630166846;68193;68220.6588967052;72151.42410046869;73229.37745506522;12153;12439.37803109859;12457.439415226156;12608.810867836806;13056.869431305566;11566.30602163873;11902.464389102684;12050.879491205327;12844.100912936005;12845.743085138432;10162.847557286794;10608.946955265174;10816.891831081588;11125.221234513507;11320.943395282971;11443.485043173243;11580.247283926517;11900.345480998281;12041.916227539214;12487.468140396642;11444.370559619301;11662.358570278717;11693.415329233674;12273.324967126537;12283.57007504733;9986.700398988041;10145.9492702536;10151.7462063449;10293.420376220993;10509.31689440184;8817.779555511164;9049.954750226207;9073;9438.244940404615;9535.38020028696 07:25:14 INFO - PROCESS | 3396 | __end_tp_report 07:25:14 INFO - PROCESS | 3396 | __start_cc_report 07:25:14 INFO - PROCESS | 3396 | _x_x_mozilla_cycle_collect,1029 07:25:14 INFO - PROCESS | 3396 | __end_cc_report 07:25:14 INFO - PROCESS | 3396 | __startTimestamp1471530314003__endTimestamp 07:25:14 INFO - PROCESS | 3396 | 07:25:14 INFO - PROCESS | 3396 | ------- Summary: start ------- 07:25:14 INFO - PROCESS | 3396 | Number of tests: 6 07:25:14 INFO - PROCESS | 3396 | 07:25:14 INFO - PROCESS | 3396 | [#0] dojo.html Cycles:165 Average:4608.55 Median:4713.06 stddev:487.42 (10.3%) stddev-sans-first:462.23 07:25:14 INFO - PROCESS | 3396 | Values: 2580.8 2588.0 2595.5 2622.9 2624.1 4539.0 4590.0 4661.0 4691.5 4709.9 4585.3 4587.9 4613.6 4620.1 4623.7 4166.2 4190.8 4231.0 4274.7 4380.8 4355.7 4364.2 4374.0 4384.6 4405.0 4139.4 4152.7 4166.6 4312.7 4324.6 4199.4 4211.3 4228.9 4257.1 4277.3 4226.1 4271.5 4282.6 4283.0 4318.9 4530.9 4672.8 4676.6 4678.1 4682.5 4903.8 4931.9 4942.5 5022.8 5028.4 4983.2 4989.8 5024.3 5028.5 5042.7 4508.6 4594.0 4693.7 4701.0 4707.0 5081.6 5123.4 5136.2 5154.5 5158.2 4903.4 4931.7 4953.6 4953.7 4954.8 4846.6 4932.7 5042.1 5042.6 5054.1 4935.3 4966.4 4976.6 4996.2 5008.7 4946.6 4954.2 4966.3 4971.9 4987.8 4111.1 4153.3 4206.5 4218.7 4249.7 3661.9 3680.1 3687.0 3728.6 3783.7 4337.2 4341.6 4372.0 4381.4 4388.3 4936.6 5030.3 5038.6 5041.4 5047.3 4245.5 4288.0 4288.4 4300.6 4336.8 4465.3 4491.4 4495.0 4498.5 4542.7 4579.0 4705.1 4713.1 4717.9 4726.1 4926.6 4929.3 4965.3 5000.0 5040.0 4675.6 4682.1 4703.0 4708.2 4750.6 4827.7 4885.4 4894.0 4895.3 4936.8 4964.1 4984.7 5019.6 5020.1 5037.1 4858.0 4864.1 4864.8 4865.6 4910.2 4727.7 4866.3 4866.7 4878.3 4918.2 4779.7 4790.4 4809.0 4813.3 4876.1 4934.9 4936.7 4938.7 4947.2 4987.0 4668.6 4820.4 4823.6 4826.8 4870.0 07:25:14 INFO - PROCESS | 3396 | 07:25:14 INFO - PROCESS | 3396 | [#1] ext.html Cycles:180 Average:47386.15 Median:19019.14 stddev:85506.64 (449.6%) stddev-sans-first:85674.24 07:25:14 INFO - PROCESS | 3396 | Values: 562.7 566.4 574.6 579.9 581.6 29026.4 39389.6 40702.4 40829.2 43999.1 40918.4 41346.1 41354.8 41378.6 41388.0 7412.1 7698.1 7841.1 7845.3 7847.4 7439.4 7684.0 7690.8 9875.9 10114.2 10197.8 10241.8 10245.7 10252.5 10271.3 10091.4 10094.7 10134.2 10153.0 10163.8 10058.6 10129.1 10131.9 10132.3 10133.6 38757.2 39068.0 39100.6 39112.6 39136.4 2986.1 3029.3 3046.7 3073.5 3106.5 28849.3 29578.1 29906.3 30027.8 30483.5 3453.3 3468.4 3509.7 3535.9 3561.9 251178.0 251188.0 251769.0 252028.0 252785.0 53530.5 53879.0 53886.0 53886.7 53969.7 32313.4 33234.5 33325.2 35181.3 35242.3 14309.3 14546.5 14548.3 14554.6 14596.6 10937.3 10996.4 11039.1 11121.9 11191.8 15966.3 16256.7 16311.6 16982.3 17793.6 6680.6 7010.6 7027.8 7094.5 7143.1 729.0 843.6 855.7 897.5 957.3 26568.5 28059.9 28126.0 28793.6 28853.7 900.1 901.6 935.8 951.4 958.6 14168.3 14928.6 15240.2 15409.3 15564.7 385329.0 387668.0 388027.0 388142.0 388519.0 50463.7 50597.5 50873.7 50956.0 50990.5 1140.7 1160.0 1164.3 1167.2 1182.1 25915.6 27074.9 27620.3 27835.9 28423.0 43307.4 43661.8 43679.1 43716.6 43810.3 318995.0 320362.0 321900.0 323827.0 324542.0 22368.4 24486.6 25281.0 25284.5 25933.7 41315.8 41746.4 42766.8 42816.6 42954.1 35915.0 36308.5 36439.8 37573.8 38161.8 36837.8 37074.6 37369.7 37486.6 37807.4 35916.3 36384.6 37234.1 37242.8 37388.0 31937.8 33396.8 33853.0 34387.2 34569.8 25175.0 25258.7 25372.2 25447.2 25944.7 07:25:14 INFO - PROCESS | 3396 | 07:25:14 INFO - PROCESS | 3396 | [#2] jquery.html Cycles:180 Average:24375.70 Median:4981.68 stddev:66839.82 (1341.7%) stddev-sans-first:67002.99 07:25:14 INFO - PROCESS | 3396 | Values: 354.5 368.1 371.2 375.3 391.5 12807.7 13222.5 15574.4 16999.2 17052.5 15111.2 15401.9 15418.5 15614.8 16327.6 4799.8 4964.9 4971.1 4971.3 4990.5 3265.7 5592.3 5815.0 5873.4 5969.5 5633.1 5907.6 5907.6 5914.7 5921.1 5803.9 5829.6 5858.3 5893.4 5896.7 4714.7 4972.9 5177.3 5204.2 5206.3 12451.7 12546.4 12591.6 12670.9 15118.6 1783.3 1837.7 1884.7 1915.3 1931.7 9028.7 9087.0 9607.6 9713.4 13323.5 1606.8 1659.7 1703.3 1720.5 1739.2 65191.7 69554.7 70189.3 70973.3 71189.3 9882.2 10064.6 10147.8 10156.7 10192.5 13384.4 13545.6 13555.1 13567.9 13668.6 6733.6 6854.6 6885.2 7018.9 7377.0 6791.3 6844.5 6877.9 7025.4 7033.2 4189.3 4238.9 4282.7 4294.4 4358.8 1754.2 1789.0 1803.6 1806.6 1827.8 757.7 784.3 831.5 835.1 861.4 16359.9 16397.2 16611.0 16843.6 17385.6 798.7 839.9 866.7 868.7 910.3 9156.0 9169.4 9590.5 9594.4 9601.9 393041.0 401371.0 405555.0 409404.0 414480.0 76472.2 77596.0 78605.6 79029.6 79878.6 912.2 932.7 951.4 957.3 959.2 14359.2 14428.4 14542.2 14714.6 15204.2 34903.3 35456.6 36003.0 36203.5 39606.0 47706.8 51430.7 51488.7 51793.0 53599.2 7023.6 7437.9 7465.5 7514.2 7657.8 9972.7 11334.3 11401.9 11616.7 11827.6 9301.0 9712.1 9768.5 9771.8 10376.7 9841.5 9941.2 10024.4 10187.2 10292.6 9700.6 9906.8 9966.5 10283.2 10287.2 7142.5 7166.2 7363.3 7645.5 7760.2 7822.4 9640.5 10047.3 10111.5 10247.5 07:25:14 INFO - PROCESS | 3396 | 07:25:14 INFO - PROCESS | 3396 | [#3] mootools.html Cycles:180 Average:5206.30 Median:4724.57 stddev:3009.89 (63.7%) stddev-sans-first:3003.21 07:25:14 INFO - PROCESS | 3396 | Values: 1191.4 1318.9 1382.8 1431.7 1665.4 6827.9 7717.7 8046.0 8058.5 8294.2 8125.5 8194.9 8197.3 8199.5 8201.4 2121.6 2124.9 2141.3 2144.6 2149.1 2099.1 2135.8 2144.5 2159.8 2170.7 2181.0 2187.4 2196.5 2201.4 2246.0 2095.7 2097.0 2102.3 2103.9 2104.9 2093.1 2143.9 2144.1 2147.8 2151.2 7837.8 8041.3 8104.4 8107.8 8134.8 4526.5 4699.8 4722.8 4724.2 4724.9 2852.7 2975.9 2998.1 3003.9 3005.9 974.6 993.6 996.8 1022.7 1040.3 11135.5 11226.3 11248.4 11248.5 11291.5 4102.9 4368.3 4504.7 4548.1 4594.1 8891.2 8964.1 8981.6 8985.4 8990.0 4531.1 4531.6 4534.9 4536.1 4538.6 3298.6 3686.0 4197.8 4222.9 4390.8 3376.7 3384.6 3454.5 3458.0 3489.1 992.1 992.5 1001.1 1015.7 1016.2 597.0 741.6 795.7 851.0 868.9 5330.6 5368.7 5483.4 5520.9 5696.3 433.9 443.5 445.5 449.1 604.5 3493.5 3655.5 3729.1 3744.9 3814.5 9651.5 10145.5 10171.9 10188.3 10198.5 10086.3 10113.9 10121.2 10122.4 10127.3 7421.8 7456.7 7627.9 7633.4 7648.2 5342.8 5361.7 5405.3 5415.1 5616.2 9210.7 9269.7 9330.9 9349.4 9433.0 8064.3 8143.0 9135.7 9435.0 9480.3 6251.4 6497.6 6501.4 6501.9 6536.4 7608.7 7619.0 7670.7 7675.9 7692.0 6507.3 6565.7 6577.6 6599.3 6600.4 6600.4 6627.5 6662.7 6676.3 6743.0 6425.8 6469.0 6479.5 6488.2 6519.8 4645.8 4791.8 4793.5 4807.0 4826.9 4610.4 4652.4 4722.5 4861.3 4889.9 07:25:14 INFO - PROCESS | 3396 | 07:25:14 INFO - PROCESS | 3396 | [#4] prototype.html Cycles:180 Average:4108.58 Median:4660.63 stddev:1183.81 (25.4%) stddev-sans-first:1152.14 07:25:14 INFO - PROCESS | 3396 | Values: 302.2 307.1 314.9 315.4 317.0 4540.3 4642.9 4669.5 4709.8 4719.9 4524.4 4632.8 4655.8 4665.4 4671.2 3716.1 3734.0 3741.7 3742.3 3747.6 3558.3 3749.2 3753.2 3758.0 3761.0 3494.8 3676.1 3700.9 3719.5 3720.3 3688.7 3689.5 3708.1 3708.3 3717.6 3293.9 3295.3 3297.4 3300.1 3301.5 4458.1 4578.2 4578.9 4615.7 4615.8 4247.5 4253.7 4259.8 4259.9 4263.8 4924.4 4938.3 4946.8 4960.3 4964.0 3363.4 3506.5 3534.0 3543.3 3625.6 5093.6 5118.2 5122.5 5133.6 5138.5 3611.5 3617.6 3621.5 3628.2 3629.0 3458.5 3662.6 3675.5 3677.3 3682.4 4144.9 4160.8 4169.4 4175.6 4176.2 4927.4 4933.3 4938.0 4946.7 4950.6 1198.7 1214.4 1254.4 1265.4 1266.9 859.4 877.9 878.1 882.2 882.6 4325.9 4344.7 4345.4 4353.7 4367.5 5016.7 5022.8 5040.9 5046.8 5064.6 4208.3 4354.3 4408.2 4423.5 4451.4 2676.9 2694.1 2697.8 2701.3 2706.3 4809.4 4831.8 4834.4 4851.5 4857.3 5057.6 5143.0 5212.4 5215.2 5249.5 4820.7 4821.4 4829.1 4833.4 4833.4 5039.8 5060.0 5064.3 5064.8 5098.9 4771.4 5006.0 5008.0 5012.4 5017.1 4817.5 4820.5 4826.3 4829.4 4846.9 3602.7 3606.3 3613.1 3618.3 3622.3 4830.2 5056.5 5074.7 5081.7 5116.8 4927.6 4951.8 4957.0 4957.5 4963.5 4953.3 4957.6 4960.6 4961.6 4968.5 4652.4 4682.3 4773.0 4895.3 4897.8 4849.5 4913.0 4965.0 4983.8 4991.6 4876.8 4886.3 4895.1 4896.7 4897.1 07:25:14 INFO - PROCESS | 3396 | 07:25:14 INFO - PROCESS | 3396 | [#5] yui.html Cycles:180 Average:18359.93 Median:24357.04 stddev:27327.92 (112.2%) stddev-sans-first:27372.06 07:25:14 INFO - PROCESS | 3396 | Values: 604.3 660.4 679.6 683.5 685.0 12342.6 13115.8 13228.7 13241.7 13260.0 12228.7 12311.5 12351.5 12359.9 12371.2 627.3 747.4 754.0 773.5 775.9 759.8 772.2 777.4 777.5 777.6 795.3 796.6 797.3 797.4 798.8 655.4 665.4 790.2 790.8 791.0 493.1 493.1 570.3 581.2 583.5 11938.2 11986.6 11990.2 11993.6 11999.3 11105.4 11771.7 11895.5 12129.2 12339.1 8769.6 8897.5 11373.6 11469.8 11722.2 4066.1 4077.9 4163.6 4170.9 4324.5 60932.4 61133.7 61954.7 62887.4 63330.4 9988.1 10056.4 10094.3 10133.9 10246.8 18613.9 18615.3 18623.6 18645.0 18648.0 6639.9 6778.7 6821.3 6929.9 7011.5 3681.0 3781.8 3834.7 3838.1 3873.5 2863.6 2985.9 2994.8 2999.9 2999.9 499.5 509.3 514.4 526.7 548.7 513.8 565.9 572.6 581.8 588.6 7283.3 7468.5 7574.2 7800.1 7867.9 494.7 541.4 598.7 619.8 621.8 3444.6 3551.5 3648.1 3660.4 3807.1 106690.0 109132.0 109520.5 113221.4 113628.4 92543.0 93463.5 94415.0 95193.5 98346.5 63627.0 63877.4 64302.7 69078.0 72596.6 7710.7 8329.8 8431.1 8448.1 8854.7 44554.6 45791.3 47204.5 48049.8 48221.0 67396.7 68193.0 68220.7 72151.4 73229.4 12153.0 12439.4 12457.4 12608.8 13056.9 11566.3 11902.5 12050.9 12844.1 12845.7 10162.8 10608.9 10816.9 11125.2 11320.9 11443.5 11580.2 11900.3 12041.9 12487.5 11444.4 11662.4 11693.4 12273.3 12283.6 9986.7 10145.9 10151.7 10293.4 10509.3 8817.8 9050.0 9073.0 9438.2 9535.4 07:25:14 INFO - PROCESS | 3396 | -------- Summary: end -------- 07:25:14 INFO - PROCESS | 3396 | 07:25:14 INFO - TEST-INFO | 3396: exit 0 07:25:14 INFO - TEST-OK | dromaeo_css | took 1122048ms 07:25:14 INFO - TEST-START | kraken 07:25:14 INFO - operating with platform_type : linux_ 07:25:14 INFO - Initialising browser for kraken test... 07:25:14 INFO - TEST-INFO | started process 3703 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcIrZ8j/profile http://localhost:58819/getInfo.html) 07:25:19 INFO - PROCESS | 3703 | __metrics Screen width/height:1600/1200 07:25:19 INFO - PROCESS | 3703 | colorDepth:24 07:25:19 INFO - PROCESS | 3703 | Browser inner width/height: 1024/697 07:25:19 INFO - PROCESS | 3703 | __metrics 07:25:19 INFO - PROCESS | 3703 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:25:19 INFO - PROCESS | 3703 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:25:20 INFO - PROCESS | 3703 | console.error: PushService: 07:25:20 INFO - PROCESS | 3703 | stateChangeProcessEnqueue: Error transitioning state 07:25:20 INFO - PROCESS | 3703 | UnknownError 07:25:20 INFO - TEST-INFO | 3703: exit 0 07:25:20 INFO - Browser initialized. 07:25:20 INFO - Running cycle 1/1 for kraken test... 07:25:20 INFO - TEST-INFO | started process 3785 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcIrZ8j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:25:32 INFO - PROCESS | 3785 | RSS: Main: 156991488 07:25:32 INFO - PROCESS | 3785 | 07:25:35 INFO - PROCESS | 3785 | Cycle 1(1): loaded http://localhost:58819/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58819/tests/kraken/driver.html?testName=audio-beat-detection) 07:25:36 INFO - PROCESS | 3785 | RSS: Main: 205049856 07:25:36 INFO - PROCESS | 3785 | 07:25:39 INFO - PROCESS | 3785 | Cycle 1(1): loaded http://localhost:58819/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58819/tests/kraken/driver.html?testName=audio-dft) 07:25:39 INFO - PROCESS | 3785 | RSS: Main: 196714496 07:25:39 INFO - PROCESS | 3785 | 07:25:42 INFO - PROCESS | 3785 | Cycle 1(1): loaded http://localhost:58819/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58819/tests/kraken/driver.html?testName=audio-fft) 07:25:43 INFO - PROCESS | 3785 | RSS: Main: 277643264 07:25:43 INFO - PROCESS | 3785 | 07:25:45 INFO - PROCESS | 3785 | Cycle 1(1): loaded http://localhost:58819/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58819/tests/kraken/driver.html?testName=audio-oscillator) 07:25:46 INFO - PROCESS | 3785 | RSS: Main: 187691008 07:25:46 INFO - PROCESS | 3785 | 07:25:48 INFO - PROCESS | 3785 | Cycle 1(1): loaded http://localhost:58819/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58819/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:25:49 INFO - PROCESS | 3785 | RSS: Main: 191959040 07:25:49 INFO - PROCESS | 3785 | 07:25:52 INFO - PROCESS | 3785 | Cycle 1(1): loaded http://localhost:58819/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58819/tests/kraken/driver.html?testName=imaging-darkroom) 07:25:53 INFO - PROCESS | 3785 | RSS: Main: 228421632 07:25:53 INFO - PROCESS | 3785 | 07:25:56 INFO - PROCESS | 3785 | Cycle 1(1): loaded http://localhost:58819/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58819/tests/kraken/driver.html?testName=imaging-desaturate) 07:25:57 INFO - PROCESS | 3785 | RSS: Main: 222097408 07:25:57 INFO - PROCESS | 3785 | 07:26:00 INFO - PROCESS | 3785 | Cycle 1(1): loaded http://localhost:58819/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58819/tests/kraken/driver.html?testName=json-parse-financial) 07:26:00 INFO - PROCESS | 3785 | RSS: Main: 225624064 07:26:00 INFO - PROCESS | 3785 | 07:26:02 INFO - PROCESS | 3785 | Cycle 1(1): loaded http://localhost:58819/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58819/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:26:03 INFO - PROCESS | 3785 | RSS: Main: 189153280 07:26:03 INFO - PROCESS | 3785 | 07:26:04 INFO - PROCESS | 3785 | Cycle 1(1): loaded http://localhost:58819/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58819/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:26:05 INFO - PROCESS | 3785 | RSS: Main: 196894720 07:26:05 INFO - PROCESS | 3785 | 07:26:07 INFO - PROCESS | 3785 | Cycle 1(1): loaded http://localhost:58819/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58819/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:26:08 INFO - PROCESS | 3785 | RSS: Main: 194060288 07:26:08 INFO - PROCESS | 3785 | 07:26:11 INFO - PROCESS | 3785 | Cycle 1(1): loaded http://localhost:58819/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58819/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:26:11 INFO - PROCESS | 3785 | RSS: Main: 189042688 07:26:11 INFO - PROCESS | 3785 | 07:26:14 INFO - PROCESS | 3785 | Cycle 1(1): loaded http://localhost:58819/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58819/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:26:15 INFO - PROCESS | 3785 | RSS: Main: 191541248 07:26:15 INFO - PROCESS | 3785 | 07:26:17 INFO - PROCESS | 3785 | Cycle 1(1): loaded http://localhost:58819/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58819/tests/kraken/driver.html?testName=ai-astar) 07:26:17 INFO - PROCESS | 3785 | RSS: Main: 242319360 07:26:17 INFO - PROCESS | 3785 | 07:26:17 INFO - PROCESS | 3785 | __start_tp_report 07:26:17 INFO - PROCESS | 3785 | _x_x_mozilla_page_load 07:26:17 INFO - PROCESS | 3785 | _x_x_mozilla_page_load_details 07:26:17 INFO - PROCESS | 3785 | |i|pagename|runs| 07:26:17 INFO - PROCESS | 3785 | |0;ai-astar;105;114;115;114;110;115;113;112;115;113 07:26:17 INFO - PROCESS | 3785 | |1;audio-beat-detection;148;130;122;195;121;123;142;123;161;125 07:26:17 INFO - PROCESS | 3785 | |2;audio-dft;161;162;162;160;161;162;162;161;160;160 07:26:17 INFO - PROCESS | 3785 | |3;audio-fft;76;75;74;108;76;78;75;76;103;77 07:26:17 INFO - PROCESS | 3785 | |4;audio-oscillator;85;86;136;87;86;87;120;88;86;138 07:26:17 INFO - PROCESS | 3785 | |5;imaging-gaussian-blur;117;116;116;117;117;117;118;117;117;117 07:26:17 INFO - PROCESS | 3785 | |6;imaging-darkroom;146;146;146;146;148;147;148;146;146;148 07:26:17 INFO - PROCESS | 3785 | |7;imaging-desaturate;95;95;94;95;94;95;95;95;95;95 07:26:17 INFO - PROCESS | 3785 | |8;json-parse-financial;66;65;67;65;66;67;65;65;67;64 07:26:17 INFO - PROCESS | 3785 | |9;json-stringify-tinderbox;65;66;65;66;66;65;65;66;66;66 07:26:17 INFO - PROCESS | 3785 | |10;stanford-crypto-aes;84;91;83;83;89;82;81;81;81;82 07:26:17 INFO - PROCESS | 3785 | |11;stanford-crypto-ccm;133;130;148;142;151;131;132;133;160;140 07:26:17 INFO - PROCESS | 3785 | |12;stanford-crypto-pbkdf2;170;174;171;175;169;172;173;170;168;171 07:26:17 INFO - PROCESS | 3785 | |13;stanford-crypto-sha256-iterative;69;67;69;67;76;67;66;69;66;68 07:26:17 INFO - PROCESS | 3785 | __end_tp_report 07:26:17 INFO - PROCESS | 3785 | __start_cc_report 07:26:17 INFO - PROCESS | 3785 | _x_x_mozilla_cycle_collect,1914 07:26:17 INFO - PROCESS | 3785 | __end_cc_report 07:26:17 INFO - PROCESS | 3785 | __startTimestamp1471530377452__endTimestamp 07:26:17 INFO - PROCESS | 3785 | 07:26:17 INFO - PROCESS | 3785 | ------- Summary: start ------- 07:26:17 INFO - PROCESS | 3785 | Number of tests: 14 07:26:17 INFO - PROCESS | 3785 | 07:26:17 INFO - PROCESS | 3785 | [#0] ai-astar Cycles:10 Average:112.60 Median:114.00 stddev:3.10 (2.7%) stddev-sans-first:1.67 07:26:17 INFO - PROCESS | 3785 | Values: 105.0 114.0 115.0 114.0 110.0 115.0 113.0 112.0 115.0 113.0 07:26:17 INFO - PROCESS | 3785 | 07:26:17 INFO - PROCESS | 3785 | [#1] audio-beat-detection Cycles:10 Average:139.00 Median:136.00 stddev:23.83 (17.5%) stddev-sans-first:25.05 07:26:17 INFO - PROCESS | 3785 | Values: 148.0 130.0 122.0 195.0 121.0 123.0 142.0 123.0 161.0 125.0 07:26:17 INFO - PROCESS | 3785 | 07:26:17 INFO - PROCESS | 3785 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:0.88 (0.5%) stddev-sans-first:0.93 07:26:17 INFO - PROCESS | 3785 | Values: 161.0 162.0 162.0 160.0 161.0 162.0 162.0 161.0 160.0 160.0 07:26:17 INFO - PROCESS | 3785 | 07:26:17 INFO - PROCESS | 3785 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:12.59 (16.6%) stddev-sans-first:13.18 07:26:17 INFO - PROCESS | 3785 | Values: 76.0 75.0 74.0 108.0 76.0 78.0 75.0 76.0 103.0 77.0 07:26:17 INFO - PROCESS | 3785 | 07:26:17 INFO - PROCESS | 3785 | [#4] audio-oscillator Cycles:10 Average:99.90 Median:86.00 stddev:22.20 (25.8%) stddev-sans-first:22.88 07:26:17 INFO - PROCESS | 3785 | Values: 85.0 86.0 136.0 87.0 86.0 87.0 120.0 88.0 86.0 138.0 07:26:17 INFO - PROCESS | 3785 | 07:26:17 INFO - PROCESS | 3785 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 07:26:17 INFO - PROCESS | 3785 | Values: 117.0 116.0 116.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 07:26:17 INFO - PROCESS | 3785 | 07:26:17 INFO - PROCESS | 3785 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:146.50 stddev:0.95 (0.6%) stddev-sans-first:0.97 07:26:17 INFO - PROCESS | 3785 | Values: 146.0 146.0 146.0 146.0 148.0 147.0 148.0 146.0 146.0 148.0 07:26:17 INFO - PROCESS | 3785 | 07:26:17 INFO - PROCESS | 3785 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 07:26:17 INFO - PROCESS | 3785 | Values: 95.0 95.0 94.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 07:26:17 INFO - PROCESS | 3785 | 07:26:17 INFO - PROCESS | 3785 | [#8] json-parse-financial Cycles:10 Average:65.70 Median:66.00 stddev:1.06 (1.6%) stddev-sans-first:1.12 07:26:17 INFO - PROCESS | 3785 | Values: 66.0 65.0 67.0 65.0 66.0 67.0 65.0 65.0 67.0 64.0 07:26:17 INFO - PROCESS | 3785 | 07:26:17 INFO - PROCESS | 3785 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 07:26:17 INFO - PROCESS | 3785 | Values: 65.0 66.0 65.0 66.0 66.0 65.0 65.0 66.0 66.0 66.0 07:26:17 INFO - PROCESS | 3785 | 07:26:17 INFO - PROCESS | 3785 | [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:3.50 (4.2%) stddev-sans-first:3.71 07:26:17 INFO - PROCESS | 3785 | Values: 84.0 91.0 83.0 83.0 89.0 82.0 81.0 81.0 81.0 82.0 07:26:17 INFO - PROCESS | 3785 | 07:26:17 INFO - PROCESS | 3785 | [#11] stanford-crypto-ccm Cycles:10 Average:140.00 Median:141.00 stddev:10.18 (7.2%) stddev-sans-first:10.47 07:26:17 INFO - PROCESS | 3785 | Values: 133.0 130.0 148.0 142.0 151.0 131.0 132.0 133.0 160.0 140.0 07:26:17 INFO - PROCESS | 3785 | 07:26:17 INFO - PROCESS | 3785 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:171.50 stddev:2.21 (1.3%) stddev-sans-first:2.30 07:26:17 INFO - PROCESS | 3785 | Values: 170.0 174.0 171.0 175.0 169.0 172.0 173.0 170.0 168.0 171.0 07:26:17 INFO - PROCESS | 3785 | 07:26:17 INFO - PROCESS | 3785 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:2.91 (4.3%) stddev-sans-first:3.08 07:26:17 INFO - PROCESS | 3785 | Values: 69.0 67.0 69.0 67.0 76.0 67.0 66.0 69.0 66.0 68.0 07:26:17 INFO - PROCESS | 3785 | -------- Summary: end -------- 07:26:17 INFO - PROCESS | 3785 | 07:26:18 INFO - TEST-INFO | 3785: exit 0 07:26:18 INFO - TEST-OK | kraken | took 63669ms 07:26:18 INFO - SUITE-END | took 1185s 07:26:18 INFO - Completed test suite (00:19:45) 07:26:18 INFO - javascript benchmark 07:26:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2580.832245904016, 2588.0424243030084, 2595.4809038192366, 2622.947541049179, 2624.147152175542, 4538.954610453894, 4589.977050114745, 4661.0, 4691.483936766957, 4709.929351059733, 4585.2663573828195, 4587.88530286743, 4613.561711637398, 4620.145273124474, 4623.653226008046, 4166.208420400129, 4190.790460476979, 4231.0, 4274.658027357804, 4380.824767009316, 4355.673324500659, 4364.214441400547, 4373.978130109345, 4384.605385515303, 4404.955950440487, 4139.441175441307, 4152.667786577097, 4166.625003749647, 4312.719673221262, 4324.610785029363, 4199.370094485821, 4211.305134652778, 4228.936565951513, 4257.084726783756, 4277.2942464493635, 4226.091390351058, 4271.508776490681, 4282.593153650399, 4282.957170428318, 4318.892027699301, 4530.8867278317975, 4672.813087476497, 4676.625869930432, 4678.064387122589, 4682.508336624674, 4903.779329930162, 4931.876703082416, 4942.505749425065, 5022.824201152978, 5028.421731500887, 4983.227599722049, 4989.800407983676, 5024.32171656829, 5028.522290382444, 5042.697438153723, 4508.639308855284, 4594.035252596992, 4693.718376897363, 4701.036287561042, 4707.03505781314, 5081.59347252219, 5123.436421993578, 5136.178211486144, 5154.484551544815, 5158.174692049254, 4903.41159060915, 4931.728754918442, 4953.578945789648, 4953.6532442729385, 4954.777035033432, 4846.5638092571835, 4932.704037757746, 5042.067217564689, 5042.6470147090085, 5054.090263752486, 4935.3090567320605, 4966.404031516241, 4976.552110310089, 4996.175631020914, 5008.6744361616375, 4946.554810067111, 4954.182559877652, 4966.279889416014, 4971.850844474671, 4987.800487980513, 4111.075008123208, 4153.27317719404, 4206.516250631216, 4218.6835987300465, 4249.745015299092, 3661.8718344857803, 3680.0799800049986, 3686.9631303687156, 3728.5712143103347, 3783.7162212834146, 4337.1976184405985, 4341.565843415633, 4371.978140109279, 4381.38660587518, 4388.319810429389, 4936.555709986119, 5030.346055012825, 5038.5969122470115, 5041.395032596112, 5047.29337892688, 4245.532991370947, 4288.035192081757, 4288.356746488052, 4300.591443812833, 4336.804843782037, 4465.330200469955, 4491.371208030879, 4495.033567782943, 4498.460184777782, 4542.704724192917, 4579.038401935631, 4705.106029854317, 4713.057388522309, 4717.882052948704, 4726.125666751662, 4926.58124059459, 4929.285253638274, 4965.30485732005, 5000.049990501793, 5039.974800125976, 4675.579197872208, 4682.063587282489, 4703.0, 4708.199606066908, 4750.572448479654, 4827.734474603931, 4885.364902562644, 4893.951060489492, 4895.290182923527, 4936.802527898843, 4964.081644895706, 4984.7258400788305, 5019.62352823547, 5020.146575082318, 5037.0681423936685, 4857.95142048575, 4864.100141473838, 4864.781084851119, 4865.63619490483, 4910.189818679878, 4727.692699974491, 4866.29438731389, 4866.7079975201605, 4878.292647566154, 4918.163912135017, 4779.713217206979, 4790.425148982005, 4808.951910480991, 4813.253945638432, 4876.073546026244, 4934.925976110289, 4936.654434189572, 4938.678985865908, 4947.158982972831, 4986.975065124651, 4668.5564871337165, 4820.39745031871, 4823.589994850477, 4826.758662066953, 4870.0], "value": 4577.230174287465, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [562.6905202138823, 566.4222493057084, 574.6264927796929, 579.8724280658254, 581.6248519704791, 29026.41947161058, 39389.60610393895, 40702.38946415803, 40829.18341633165, 43999.12001759971, 40918.38622420666, 41346.10577259593, 41354.79322603383, 41378.58621413785, 41388.0, 7412.073490813648, 7698.114716807569, 7841.05907291123, 7845.254700803414, 7847.372210223169, 7439.404847612178, 7683.961580192091, 7690.807729806744, 9875.851862222073, 10114.2414318926, 10197.847032294521, 10241.84637230442, 10245.743856403613, 10252.538635761408, 10271.28101032928, 10091.444970526618, 10094.697159085239, 10134.189264858793, 10152.984701529862, 10163.847542286872, 10058.647947321882, 10129.088382045651, 10131.949340253324, 10132.290739648228, 10133.594656213743, 38757.22485550273, 39068.0, 39100.60899391027, 39112.60887391118, 39136.41295380572, 2986.089242780951, 3029.3184033592484, 3046.6953304669355, 3073.462144124769, 3106.502959526465, 28849.278768030967, 29578.112656620335, 29906.252343691365, 30027.849860750557, 30483.542746858813, 3453.2748122894222, 3468.4486097970725, 3509.7192224621967, 3535.8585656573705, 3561.94657080144, 251178.0, 251188.0, 251769.0, 252028.0, 252785.0, 53530.464695352544, 53879.0, 53886.0, 53886.7305663477, 53969.73015134978, 32313.35373292568, 33234.50148247778, 33325.16687082842, 35181.29637407237, 35242.29515409678, 14309.28453577317, 14546.4908728194, 14548.345324460424, 14554.636134096521, 14596.56210313671, 10937.289076210021, 10996.395198264172, 11039.061679757311, 11121.888781112086, 11191.776164476665, 15966.323536028782, 16256.67486650284, 16311.553267009805, 16982.320707171573, 17793.644127117386, 6680.565763225375, 7010.649467526603, 7027.754028608974, 7094.467914906402, 7143.107111611049, 728.992710072903, 843.5613480989973, 855.7090589199702, 897.528797381367, 957.3203025851724, 26568.468630627278, 28059.859700701367, 28126.0, 28793.568096478568, 28853.7114628851, 900.1178844732199, 901.6123067081218, 935.7529373075417, 951.3863558005048, 958.6069711418425, 14168.291585420893, 14928.552143435714, 15240.161791101596, 15409.306581203873, 15564.688706225812, 385329.0, 387668.0, 388027.0, 388142.0, 388519.0, 50463.747681262095, 50597.49402506001, 50873.74563127161, 50956.0, 50990.49009509932, 1140.7376303450253, 1160.0313738028672, 1164.3130552973616, 1167.200467679642, 1182.1370399608163, 25915.611265831405, 27074.864625677532, 27620.309492262855, 27835.860820695765, 28423.0, 43307.35038974355, 43661.78169109134, 43679.12641747211, 43716.56283437125, 43810.342844856714, 318995.0, 320362.0, 321900.0, 323827.0, 324542.0, 22368.440788980406, 24486.632700509865, 25281.0, 25284.49431011333, 25933.740662593133, 41315.7934210327, 41746.37380439357, 42766.786166068974, 42816.57183428126, 42954.140917180855, 35915.0, 36308.45537316995, 36439.81780091082, 37573.81213093917, 38161.80919095498, 36837.81581092185, 37074.6292537082, 37369.719150289704, 37486.62513374831, 37807.43288850615, 35916.28167436689, 36384.63615363812, 37234.06914827151, 37242.8137859309, 37388.0, 31937.840310798296, 33396.833015835735, 33853.0, 34387.15418378932, 34569.82715086408, 25175.0, 25258.747412526376, 25372.238832835046, 25447.182922561762, 25944.740552594234], "value": 17738.941047908524, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [354.5373287859343, 368.10550362618824, 371.20561997325746, 375.283209070675, 391.5458068640378, 12807.743845123103, 13222.53721119761, 15574.364691707364, 16999.23503442345, 17052.48842534726, 15111.168885711282, 15401.922990385032, 15418.537443876674, 15614.76577851333, 16327.59181020475, 4799.760011999395, 4964.851054468371, 4971.055499455092, 4971.304017437562, 4990.500949905017, 3265.7060864522186, 5592.3009623797025, 5815.0, 5873.353931067601, 5969.462748352647, 5633.070543360361, 5907.556933230004, 5907.556933230004, 5914.674692891911, 5921.052631578948, 5803.883922321551, 5829.562782791287, 5858.326292476378, 5893.410658934073, 5896.705164741746, 4714.669973101884, 4972.8508144755715, 5177.301064356301, 5204.219367094928, 5206.297149884755, 12451.688707782287, 12546.435410406553, 12591.559295424617, 12670.873291267062, 15118.622034449118, 1783.3312507809571, 1837.660032893919, 1884.67960446723, 1915.2721965652963, 1931.652302585534, 9028.729138125802, 9087.000429952699, 9607.56765945534, 9713.417194968253, 13323.467061317633, 1606.7911171547742, 1659.7095508286122, 1703.2505697493186, 1720.5268551148533, 1739.226044410238, 65191.674041629965, 69554.65222673854, 70189.29810701878, 70973.29026709718, 71189.2881071193, 9882.160016398542, 10064.597416103274, 10147.847782283272, 10156.746081348025, 10192.541335639915, 13384.397702103428, 13545.593632190852, 13555.118917270544, 13567.932160339134, 13668.589942301747, 6733.595984240961, 6854.554453960576, 6885.173779146434, 7018.894716579255, 7377.0409846719585, 6791.252962174157, 6844.486663500257, 6877.89683154753, 7025.402840758593, 7033.226345102034, 4189.287821070426, 4238.915221695611, 4282.735469114349, 4294.441722576045, 4358.760268185217, 1754.2106052276526, 1788.9821101788816, 1803.603207294393, 1806.6115785106265, 1827.7532533108126, 757.7310054930531, 784.2510402565537, 831.476170012888, 835.1439774231461, 861.3755027604936, 16359.91820040916, 16397.180140992903, 16611.0, 16843.578910527336, 17385.56536086608, 798.66456088443, 839.9454035487673, 866.7183165471247, 868.6568805321989, 910.2854259406334, 9155.954220228856, 9169.449833010041, 9590.472524011246, 9594.376365536218, 9601.855972160423, 393041.0, 401371.0, 405555.0, 409404.0, 414480.0, 76472.23527764651, 77596.0, 78605.60697196478, 79029.60485197652, 79878.6006069966, 912.2428384440898, 932.7155217658543, 951.4481600671594, 957.3155194036158, 959.1990687775785, 14359.210243436712, 14428.350724217225, 14542.200178990257, 14714.63213419673, 15204.163770992702, 34903.30193396169, 35456.64543354533, 36003.0, 36203.45694814527, 39606.0, 47706.761466192445, 51430.74284628553, 51488.742556286976, 51793.0, 53599.19601206063, 7023.613701246481, 7437.888431673638, 7465.477416580788, 7514.173440921603, 7657.770266892002, 9972.650957216463, 11334.263272887236, 11401.942990284995, 11616.651500455, 11827.645170644895, 9300.953495232481, 9712.125908668253, 9768.511574421393, 9771.804563908825, 10376.688699339033, 9841.45871977048, 9941.155001824925, 10024.448655324028, 10187.235957303084, 10292.639757608447, 9700.563474643517, 9906.801863962824, 9966.50167491637, 10283.228757843042, 10287.177025838064, 7142.5000249982, 7166.211716711054, 7363.263673632594, 7645.541267523967, 7760.18518055596, 7822.413319000984, 9640.469774162488, 10047.346922450017, 10111.544980476043, 10247.487625618838], "value": 7988.876817204817, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1191.4459776204073, 1318.8878945289646, 1382.7511048011356, 1431.685029293555, 1665.3671604790177, 6827.897581536275, 7717.652705628247, 8046.0, 8058.476199047065, 8294.170582941702, 8125.471844330114, 8194.91805081949, 8197.262246397822, 8199.549024803633, 8201.384896132799, 2121.596896589647, 2124.8725076495384, 2141.3468891987936, 2144.6246906791325, 2149.0866381787755, 2099.128861522466, 2135.797099275574, 2144.5496445746335, 2159.773223811501, 2170.6743988401786, 2180.9672854907108, 2187.3656639574583, 2196.4728465168323, 2201.361605134509, 2245.977540224593, 2095.685647152939, 2096.9895150524226, 2102.3482720356737, 2103.9263625773024, 2104.8737075775502, 2093.089506064867, 2143.9035243414082, 2144.07804644003, 2147.795959383856, 2151.193302511558, 7837.843243135162, 8041.276285134366, 8104.351651867836, 8107.837843243161, 8134.837303253961, 4526.456825180966, 4699.765011749399, 4722.834700785456, 4724.220503616899, 4724.929126063112, 2852.7289907458758, 2975.895843645462, 2998.1155559110116, 3003.8798448062053, 3005.9098227053223, 974.6101559376235, 993.5727637116037, 996.8305388084043, 1022.6676330192718, 1040.3393844908462, 11135.498902549405, 11226.270292431047, 11248.381339026431, 11248.493817778219, 11291.548338066468, 4102.917941641151, 4368.27923392643, 4504.684672072924, 4548.067646132535, 4594.1271158479785, 8891.19979201875, 8964.14840590143, 8981.550922453851, 8985.415947963362, 8989.955050224838, 4531.116432295737, 4531.614812740954, 4534.886627834265, 4536.070105628338, 4538.636909047268, 3298.640955996852, 3686.0416291764336, 4197.790110494524, 4222.852200172979, 4390.8024138913825, 3376.74674399421, 3384.5769278840144, 3454.516367708523, 3458.0, 3489.1102768793794, 992.1318846009741, 992.533509250651, 1001.0590045357341, 1015.7409860485529, 1016.1718199667396, 596.9641821490725, 741.6440108747831, 795.681727309081, 850.9531975741394, 868.8740132680853, 5330.626856120112, 5368.677879327252, 5483.369412517612, 5520.861978450571, 5696.287964004499, 433.87417648882104, 443.51213664968276, 445.5143893156475, 449.12196655538344, 604.4620287943734, 3493.4934434506854, 3655.451682247684, 3729.0863738383728, 3744.8689295874515, 3814.5422549294262, 9651.469169195761, 10145.543450544596, 10171.949140254252, 10188.286819922534, 10198.490075496196, 10086.29395942277, 10113.898861011443, 10121.1903047756, 10122.443265620313, 10127.341722787995, 7421.777346679608, 7456.664450099758, 7627.8855817162785, 7633.358827852038, 7648.196939321514, 5342.78628854857, 5361.678299302054, 5405.324334458192, 5415.1335786274, 5616.21373007771, 9210.677626283048, 9269.67556135532, 9330.860037099585, 9349.39228950116, 9433.0, 8064.274215320649, 8143.02283725933, 9135.680251191443, 9435.0, 9480.288978326791, 6251.4061164189325, 6497.642629655415, 6501.414872661483, 6501.8699626008165, 6536.444402225674, 7608.695652173851, 7619.0, 7670.7315243966195, 7675.850761786709, 7692.0, 6507.349265073455, 6565.704543295467, 6577.638229897401, 6599.340065993362, 6600.372964568358, 6600.372964568358, 6627.4698024158915, 6662.700178491883, 6676.265610782907, 6742.9662851685425, 6425.839354016187, 6468.967655161882, 6479.546431749733, 6488.156539650005, 6519.771807986887, 4645.814167433265, 4791.808327666854, 4793.472718001087, 4807.0, 4826.86045588119, 4610.423697037871, 4652.441706995182, 4722.480527141943, 4861.270809378621, 4889.853304400874], "value": 4085.813885702107, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [302.23232988209946, 307.12775716963824, 314.9212696825794, 315.37398264445085, 316.98256595887216, 4540.250858608326, 4642.8839279018, 4669.509701481346, 4709.788059537321, 4719.929201061983, 4524.411826462555, 4632.768361581924, 4655.837045703401, 4665.4168228971375, 4671.243966060024, 3716.1267102230954, 3733.9626603733886, 3741.7006639468914, 3742.270257299828, 3747.5502939647213, 3558.34170678424, 3749.1939233064886, 3753.1555400035045, 3758.0, 3761.0, 3494.8077855717925, 3676.0809797550614, 3700.9259814803686, 3719.460678201659, 3720.2931443025736, 3688.723345749053, 3689.465027571014, 3708.091517578197, 3708.2583483303447, 3717.587316819605, 3293.901182964491, 3295.2915123248376, 3297.38998285318, 3300.1254667513126, 3301.5377847101427, 4458.1306645204195, 4578.198815207325, 4578.908421831578, 4615.676902616819, 4615.792289346954, 4247.469066366704, 4253.702240843142, 4259.76571288579, 4259.91480170398, 4263.829446822124, 4924.433690125646, 4938.2839488274, 4946.752662366867, 4960.2559616057515, 4964.0, 3363.445031569788, 3506.50908872758, 3533.964660353415, 3543.326767914088, 3625.5649322081517, 5093.567046801027, 5118.181091025455, 5122.462141475166, 5133.563647090002, 5138.482143749536, 3611.476335931275, 3617.6382361763613, 3621.511096002006, 3628.1836586767768, 3628.9818550907075, 3458.544433452277, 3662.597114317423, 3675.503806986076, 3677.3196958562753, 3682.447632855093, 4144.91710165795, 4160.750354978711, 4169.395437661522, 4175.5824417558, 4176.206520761046, 4927.384076990376, 4933.309336692866, 4938.037177693427, 4946.727929963887, 4950.5544500994365, 1198.6943329451108, 1214.4352875912743, 1254.4166962362362, 1265.3862876504888, 1266.8661547914749, 859.4155973937783, 877.8814859993947, 878.1295839861056, 882.2368651116738, 882.6337070115958, 4325.9134817303475, 4344.674149438804, 4345.435093437833, 4353.673474489426, 4367.497737760134, 5016.698998060128, 5022.84931452057, 5040.924386134211, 5046.84859454217, 5064.569511591556, 4208.305629571148, 4354.303311470149, 4408.228560002051, 4423.535528769433, 4451.399061126771, 2676.892924283007, 2694.0871980893785, 2697.7572018518426, 2701.2571542825485, 2706.282835048714, 4809.374781278411, 4831.830885918976, 4834.419869615598, 4851.51484851512, 4857.295692124622, 5057.6459647824295, 5142.9742851286255, 5212.4266330703595, 5215.217717342429, 5249.456616783656, 4820.71075735457, 4821.421429428491, 4829.1307564638, 4833.4441539222735, 4833.4441539223435, 5039.84880453587, 5060.0, 5064.290999260033, 5064.772085256246, 5098.903735696843, 4771.379720636295, 5006.048850718352, 5007.974960125176, 5012.423571289202, 5017.122003649274, 4817.5182481752945, 4820.469748327611, 4826.276058591239, 4829.372181616367, 4846.909445374903, 3602.729795265313, 3606.3328284267495, 3613.0786649404236, 3618.3306088373733, 3622.3117607654463, 4830.203016502238, 5056.469070747518, 5074.695518268915, 5081.72050537224, 5116.769745361393, 4927.581155601671, 4951.826686066114, 4956.950430495649, 4957.479464656303, 4963.528464795839, 4953.331300274417, 4957.553820156203, 4960.578350840219, 4961.5534601886, 4968.503149685002, 4652.441706995182, 4682.297655351725, 4773.0, 4895.265710143364, 4897.779599917941, 4849.466558678613, 4913.0, 4964.950350496449, 4983.825566105169, 4991.6006719463085, 4876.78054487556, 4886.29148773433, 4895.143349913679, 4896.730679812645, 4897.069556784199], "value": 3738.764200782415, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [604.2926645032724, 660.3792435110998, 679.6160169504227, 683.4942142814317, 684.9691763870628, 12342.629721108358, 13115.803262951064, 13228.735425291501, 13241.735165296688, 13260.0, 12228.694282642939, 12311.507539698401, 12351.50593976242, 12359.876401235984, 12371.19587226832, 627.3130921640796, 747.4356860570261, 754.0348354106738, 773.5397438524069, 775.9146493885668, 759.7644730133649, 772.1814876231213, 777.4324742937631, 777.5334799120538, 777.5839925639784, 795.3358945280669, 796.5857753967933, 797.2704974947916, 797.3939805747644, 798.7563793043148, 655.354475841296, 665.4044630056072, 790.2137373313561, 790.8299715561153, 790.9723159689383, 493.0853267189384, 493.1468559392271, 570.3070769015625, 581.1718301420501, 583.4573846322918, 11938.164328496921, 11986.580469683518, 11990.16068875179, 11993.64019079429, 11999.340036298001, 11105.444727763579, 11771.7057073573, 11895.46470408825, 12129.21160124589, 12339.136260461772, 8769.649214031431, 8897.466152030898, 11373.601923932623, 11469.827952580717, 11722.179447438682, 4066.146109317047, 4077.8980525486804, 4163.646090082347, 4170.874873753762, 4324.502682191525, 60932.39067609311, 61133.69433152806, 61954.69022654903, 62887.371126288606, 63330.36669633245, 9988.101070903653, 10056.396616203052, 10094.293399462114, 10133.898661013443, 10246.846297305547, 18613.906930465262, 18615.348462803737, 18623.627527449375, 18644.974526400907, 18648.0, 6639.900401493981, 6778.694958726869, 6821.283765204582, 6929.861402771916, 7011.474139439562, 3680.9631903681156, 3781.8487260509823, 3834.6548810606623, 3838.1364193056897, 3873.496445462128, 2863.5847802068583, 2985.850707464618, 2994.82031078136, 2999.9100026999226, 2999.9400011999637, 499.5404228110075, 509.28699820251944, 514.3673281863254, 526.7497938479191, 548.6735392441491, 513.8355726167665, 565.8557067947647, 572.6249306704116, 581.8370856160282, 588.5938702295488, 7283.308085731847, 7468.477206595486, 7574.204708505637, 7800.102988156321, 7867.921320786719, 494.6611571073826, 541.4017510650752, 598.6527813867946, 619.8316174012019, 621.8476473263988, 3444.6383129771516, 3551.5205447264807, 3648.087978005499, 3660.377735784923, 3807.1433927366675, 106690.0, 109132.0, 109520.45239773909, 113221.43389283166, 113628.43185784019, 92543.0, 93463.53268233615, 94415.0, 95193.5240323794, 98346.50826745821, 63627.0, 63877.36122638714, 64302.67848660727, 69078.0, 72596.63701681458, 7710.683345558237, 8329.83340333202, 8431.072582016095, 8448.112948140602, 8854.690085846965, 44554.55445445504, 45791.31313030374, 47204.52795472139, 48049.75975120102, 48221.0, 67396.6630166846, 68193.0, 68220.6588967052, 72151.42410046869, 73229.37745506522, 12153.0, 12439.37803109859, 12457.439415226156, 12608.810867836806, 13056.869431305566, 11566.30602163873, 11902.464389102684, 12050.879491205327, 12844.100912936005, 12845.743085138432, 10162.847557286794, 10608.946955265174, 10816.891831081588, 11125.221234513507, 11320.943395282971, 11443.485043173243, 11580.247283926517, 11900.345480998281, 12041.916227539214, 12487.468140396642, 11444.370559619301, 11662.358570278717, 11693.415329233674, 12273.324967126537, 12283.57007504733, 9986.700398988041, 10145.9492702536, 10151.7462063449, 10293.420376220993, 10509.31689440184, 8817.779555511164, 9049.954750226207, 9073.0, 9438.244940404615, 9535.38020028696], "value": 6525.744383837533, "unit": "score"}], "name": "dromaeo_css", "value": 6335.546029156309, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 114.0, 115.0, 114.0, 110.0, 115.0, 113.0, 112.0, 115.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 130.0, 122.0, 195.0, 121.0, 123.0, 142.0, 123.0, 161.0, 125.0], "value": 139.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 162.0, 160.0, 161.0, 162.0, 162.0, 161.0, 160.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 74.0, 108.0, 76.0, 78.0, 75.0, 76.0, 103.0, 77.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 136.0, 87.0, 86.0, 87.0, 120.0, 88.0, 86.0, 138.0], "value": 99.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 148.0, 147.0, 148.0, 146.0, 146.0, 148.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 65.0, 66.0, 67.0, 65.0, 65.0, 67.0, 64.0], "value": 65.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 66.0, 65.0, 65.0, 66.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 91.0, 83.0, 83.0, 89.0, 82.0, 81.0, 81.0, 81.0, 82.0], "value": 83.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 148.0, 142.0, 151.0, 131.0, 132.0, 133.0, 160.0, 140.0], "value": 140.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 174.0, 171.0, 175.0, 169.0, 172.0, 173.0, 170.0, 168.0, 171.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 69.0, 67.0, 76.0, 67.0, 66.0, 69.0, 66.0, 68.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1547.5, "alertThreshold": 2.0}]} 07:26:18 INFO - Return code: 0 07:26:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:26:18 INFO - # TBPL SUCCESS # 07:26:18 INFO - Running post-action listener: _resource_record_post_action 07:26:18 INFO - [mozharness: 2016-08-18 14:26:18.769327Z] Finished run-tests step (success) 07:26:18 INFO - Running post-run listener: _resource_record_post_run 07:26:18 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 7684096; Write bytes: 357011456; Read time: 944; Write time: 271380 07:26:18 INFO - TinderboxPrint: CPU usage
12.9% 07:26:18 INFO - TinderboxPrint: I/O read bytes / time
7,684,096 / 944 07:26:18 INFO - TinderboxPrint: I/O write bytes / time
357,011,456 / 271,380 07:26:18 INFO - TinderboxPrint: CPU idle
8,349.8 (87.0%) 07:26:18 INFO - TinderboxPrint: CPU user
1,199.1 (12.5%) 07:26:18 INFO - TinderboxPrint: Swap in / out
0 / 0 07:26:18 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 8192; Write bytes: 64778240; Read time: 28; Write time: 40932 07:26:18 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 5435392; Write bytes: 265273344; Read time: 744; Write time: 199160 07:26:19 INFO - Running post-run listener: _upload_blobber_files 07:26:19 INFO - Blob upload gear active. 07:26:19 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:26:19 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:26:19 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:26:19 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:26:19 INFO - (blobuploader) - INFO - Open directory for files ... 07:26:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:26:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:26:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:30 INFO - (blobuploader) - INFO - Done attempting. 07:26:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:26:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:26:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:30 INFO - (blobuploader) - INFO - Done attempting. 07:26:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:26:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:26:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:26:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:26:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:26:31 INFO - (blobuploader) - INFO - Done attempting. 07:26:31 INFO - (blobuploader) - INFO - Iteration through files over. 07:26:31 INFO - Return code: 0 07:26:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:26:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:26:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/005aaf41e65b811dc1353688cb4364c749744da6a1b266da7b60f59b804b01c943a5fd111f6b631004d8ba3ea7129633f11dee306d2fa3701eaa66f1ed3ff2f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6e58a6e0870ddf3320721553ea85fb9d3f11b8f62c1dcf8df6c060c2f3f930ed064296d136c3a551dac1c821033d379c52981f82afc0515a1f829f931f7d7b97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7af8944b9fdd6e5558eae26cee3434b781fb1c7f47262d1b8168df427434c89d3e92872c5074f22d25b8ec9c15724f32081188ffd309cf27c388da09637a4ac9"} 07:26:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:26:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:26:31 INFO - Contents: 07:26:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/005aaf41e65b811dc1353688cb4364c749744da6a1b266da7b60f59b804b01c943a5fd111f6b631004d8ba3ea7129633f11dee306d2fa3701eaa66f1ed3ff2f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6e58a6e0870ddf3320721553ea85fb9d3f11b8f62c1dcf8df6c060c2f3f930ed064296d136c3a551dac1c821033d379c52981f82afc0515a1f829f931f7d7b97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7af8944b9fdd6e5558eae26cee3434b781fb1c7f47262d1b8168df427434c89d3e92872c5074f22d25b8ec9c15724f32081188ffd309cf27c388da09637a4ac9"} 07:26:31 INFO - Running post-run listener: copy_logs_to_upload_dir 07:26:31 INFO - Copying logs to upload dir... 07:26:31 INFO - mkdir: /builds/slave/test/build/upload/logs 07:26:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1254.836300 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 54 secs) (at 2016-08-18 07:26:31.715805) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 07:26:31.719531) ========= 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=20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/005aaf41e65b811dc1353688cb4364c749744da6a1b266da7b60f59b804b01c943a5fd111f6b631004d8ba3ea7129633f11dee306d2fa3701eaa66f1ed3ff2f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6e58a6e0870ddf3320721553ea85fb9d3f11b8f62c1dcf8df6c060c2f3f930ed064296d136c3a551dac1c821033d379c52981f82afc0515a1f829f931f7d7b97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7af8944b9fdd6e5558eae26cee3434b781fb1c7f47262d1b8168df427434c89d3e92872c5074f22d25b8ec9c15724f32081188ffd309cf27c388da09637a4ac9"} build_url:https://queue.taskcluster.net/v1/task/D-pCWEEQSYmtHEo9I9KBdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011188 build_url: 'https://queue.taskcluster.net/v1/task/D-pCWEEQSYmtHEo9I9KBdw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/005aaf41e65b811dc1353688cb4364c749744da6a1b266da7b60f59b804b01c943a5fd111f6b631004d8ba3ea7129633f11dee306d2fa3701eaa66f1ed3ff2f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6e58a6e0870ddf3320721553ea85fb9d3f11b8f62c1dcf8df6c060c2f3f930ed064296d136c3a551dac1c821033d379c52981f82afc0515a1f829f931f7d7b97", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/7af8944b9fdd6e5558eae26cee3434b781fb1c7f47262d1b8168df427434c89d3e92872c5074f22d25b8ec9c15724f32081188ffd309cf27c388da09637a4ac9"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 07:26:31.745726) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 07:26:31.746097) ========= 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=20e666a3d4cfbb71505a330e000001b4-1471528989.861193-1774551601 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004427 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 07:26:31.797079) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 07:26:31.797397) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 07:26:31.797690) ========= ========= Total master_lag: 0.14 =========