builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-002 starttime: 1472104833.23 results: success (0) buildid: 20160824222726 builduid: 6921e95839154b0fb69eeef7a5a5f82e revision: ac729cd10150901662bbdab08f685641349fa610 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 23:00:33.232833) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-24 23:00:33.233293) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 23:00:33.233615) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-24 23:00:33.249704) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 23:00:33.250035) ========= 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=a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-24 23:00:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.1M=0s 2016-08-24 23:00:33 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130336 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 23:00:33.394568) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 23:00:33.394951) ========= 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=a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014601 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 23:00:33.445408) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 23:00:33.445906) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev ac729cd10150901662bbdab08f685641349fa610 --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 ac729cd10150901662bbdab08f685641349fa610 --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=a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-24 23:00:33,524 truncating revision to first 12 chars 2016-08-24 23:00:33,524 Setting DEBUG logging. 2016-08-24 23:00:33,524 attempt 1/10 2016-08-24 23:00:33,524 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/ac729cd10150?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-24 23:00:33,816 unpacking tar archive at: autoland-ac729cd10150/testing/mozharness/ program finished with exit code 0 elapsedTime=0.703483 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 23:00:34.165587) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 23:00:34.166006) ========= script_repo_revision: ac729cd10150901662bbdab08f685641349fa610 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-24 23:00:34.166465) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 23:00:34.166757) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-24 23:00:34.177657) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-24 23:00:34.178087) ========= /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=a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:00:34 INFO - MultiFileLogger online at 20160824 23:00:34 in /builds/slave/test 23:00:34 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 23:00:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:00:34 INFO - {'append_to_log': False, 23:00:34 INFO - 'base_work_dir': '/builds/slave/test', 23:00:34 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 23:00:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:00:34 INFO - 'branch': 'Autoland-Non-PGO', 23:00:34 INFO - 'buildbot_json_path': 'buildprops.json', 23:00:34 INFO - 'config_files': ('talos/linux_config.py',), 23:00:34 INFO - 'default_actions': ('clobber', 23:00:34 INFO - 'read-buildbot-config', 23:00:34 INFO - 'download-and-extract', 23:00:34 INFO - 'populate-webroot', 23:00:34 INFO - 'create-virtualenv', 23:00:34 INFO - 'install', 23:00:34 INFO - 'run-tests'), 23:00:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:00:34 INFO - 'download_minidump_stackwalk': True, 23:00:34 INFO - 'download_symbols': 'ondemand', 23:00:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:00:34 INFO - 'tooltool.py': '/tools/tooltool.py', 23:00:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:00:34 INFO - '/tools/misc-python/virtualenv.py')}, 23:00:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:00:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:00:34 INFO - 'installer_path': 'installer.exe', 23:00:34 INFO - 'log_level': 'info', 23:00:34 INFO - 'log_name': 'talos', 23:00:34 INFO - 'log_to_console': True, 23:00:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:00:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:00:34 INFO - 'opt_config_files': (), 23:00:34 INFO - 'pip_index': False, 23:00:34 INFO - 'sps_profile': False, 23:00:34 INFO - 'sps_profile_interval': 0, 23:00:34 INFO - 'suite': 'dromaeojs', 23:00:34 INFO - 'system_bits': '32', 23:00:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:00:34 INFO - 'title': 'talos-linux64-ix-002', 23:00:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:00:34 INFO - 'use_talos_json': True, 23:00:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:00:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:00:34 INFO - 'work_dir': 'build'} 23:00:34 INFO - [mozharness: 2016-08-25 06:00:34.354641Z] Running clobber step. 23:00:34 INFO - Running pre-action listener: _resource_record_pre_action 23:00:34 INFO - Running main action method: clobber 23:00:34 INFO - rmtree: /builds/slave/test/build 23:00:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:00:34 INFO - Running post-action listener: _resource_record_post_action 23:00:34 INFO - [mozharness: 2016-08-25 06:00:34.811168Z] Finished clobber step (success) 23:00:34 INFO - [mozharness: 2016-08-25 06:00:34.811269Z] Running read-buildbot-config step. 23:00:34 INFO - Running pre-action listener: _resource_record_pre_action 23:00:34 INFO - Running main action method: read_buildbot_config 23:00:34 INFO - Using buildbot properties: 23:00:34 INFO - { 23:00:34 INFO - "project": "", 23:00:34 INFO - "product": "firefox", 23:00:34 INFO - "script_repo_revision": "production", 23:00:34 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 23:00:34 INFO - "repository": "", 23:00:34 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 23:00:34 INFO - "buildid": "20160824222726", 23:00:34 INFO - "pgo_build": "False", 23:00:34 INFO - "basedir": "/builds/slave/test", 23:00:34 INFO - "buildnumber": 359, 23:00:34 INFO - "slavename": "talos-linux64-ix-002", 23:00:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 23:00:34 INFO - "platform": "ubuntu64_hw", 23:00:34 INFO - "scheduler": "tests-autoland-linux64-talos", 23:00:34 INFO - "branch": "autoland", 23:00:34 INFO - "repo_path": "integration/autoland", 23:00:34 INFO - "revision": "ac729cd10150901662bbdab08f685641349fa610", 23:00:34 INFO - "stage_platform": "linux64", 23:00:34 INFO - "builduid": "6921e95839154b0fb69eeef7a5a5f82e", 23:00:34 INFO - "slavebuilddir": "test" 23:00:34 INFO - } 23:00:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/X_fQtgN6R0GX7Rye9CdejA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 23:00:34 INFO - Running post-action listener: _resource_record_post_action 23:00:34 INFO - [mozharness: 2016-08-25 06:00:34.813668Z] Finished read-buildbot-config step (success) 23:00:34 INFO - [mozharness: 2016-08-25 06:00:34.813754Z] Running download-and-extract step. 23:00:34 INFO - Running pre-action listener: _resource_record_pre_action 23:00:34 INFO - Running main action method: download_and_extract 23:00:34 INFO - mkdir: /builds/slave/test/build/tests 23:00:34 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')]} 23:00:34 INFO - trying https://queue.taskcluster.net/v1/task/X_fQtgN6R0GX7Rye9CdejA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:00:34 INFO - Downloading https://queue.taskcluster.net/v1/task/X_fQtgN6R0GX7Rye9CdejA/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 23:00:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X_fQtgN6R0GX7Rye9CdejA/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 23:00:35 INFO - Downloaded 1361 bytes. 23:00:35 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:00:35 INFO - Using the following test package requirements: 23:00:35 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:00:35 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:00:35 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:00:35 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:35 INFO - u'jsshell-linux-x86_64.zip'], 23:00:35 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:00:35 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:00:35 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:00:35 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:00:35 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:00:35 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:00:35 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:00:35 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:00:35 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')]} 23:00:35 INFO - trying https://queue.taskcluster.net/v1/task/X_fQtgN6R0GX7Rye9CdejA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:00:35 INFO - Downloading https://queue.taskcluster.net/v1/task/X_fQtgN6R0GX7Rye9CdejA/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 23:00:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X_fQtgN6R0GX7Rye9CdejA/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 23:00:36 INFO - Downloaded 20324724 bytes. 23:00:36 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 23:00:40 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 23:00:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:00:40 INFO - trying https://queue.taskcluster.net/v1/task/X_fQtgN6R0GX7Rye9CdejA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:00:40 INFO - Downloading https://queue.taskcluster.net/v1/task/X_fQtgN6R0GX7Rye9CdejA/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 23:00:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X_fQtgN6R0GX7Rye9CdejA/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 23:00:41 INFO - Downloaded 20324724 bytes. 23:00:41 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 23:00:45 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')]} 23:00:45 INFO - trying https://queue.taskcluster.net/v1/task/X_fQtgN6R0GX7Rye9CdejA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 23:00:45 INFO - Downloading https://queue.taskcluster.net/v1/task/X_fQtgN6R0GX7Rye9CdejA/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 23:00:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/X_fQtgN6R0GX7Rye9CdejA/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 23:00:46 INFO - Downloaded 14413981 bytes. 23:00:46 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 23:00:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:00:46 INFO - trying https://queue.taskcluster.net/v1/task/X_fQtgN6R0GX7Rye9CdejA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:00:46 INFO - Downloading https://queue.taskcluster.net/v1/task/X_fQtgN6R0GX7Rye9CdejA/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 23:00:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/X_fQtgN6R0GX7Rye9CdejA/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 23:00:48 INFO - Downloaded 55759605 bytes. 23:00:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/X_fQtgN6R0GX7Rye9CdejA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:00:48 INFO - mkdir: /builds/slave/test/properties 23:00:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:00:48 INFO - Writing to file /builds/slave/test/properties/build_url 23:00:48 INFO - Contents: 23:00:48 INFO - build_url:https://queue.taskcluster.net/v1/task/X_fQtgN6R0GX7Rye9CdejA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:00:48 INFO - Running post-action listener: _resource_record_post_action 23:00:48 INFO - Running post-action listener: set_extra_try_arguments 23:00:48 INFO - [mozharness: 2016-08-25 06:00:48.726366Z] Finished download-and-extract step (success) 23:00:48 INFO - [mozharness: 2016-08-25 06:00:48.726591Z] Running populate-webroot step. 23:00:48 INFO - Running pre-action listener: _resource_record_pre_action 23:00:48 INFO - Running main action method: populate_webroot 23:00:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:00:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:00:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:00:48 INFO - '--tppagecycles', 23:00:48 INFO - '7'], 23:00:48 INFO - 'tests': ['tsvgm']}}, 23:00:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:00:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:00:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:00:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:00:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:00:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:00:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:48 INFO - 'talos_options': ['--disable-e10s'], 23:00:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:00:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:00:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:48 INFO - 'talos_options': ['--disable-e10s'], 23:00:48 INFO - 'tests': ['damp', 'tps']}, 23:00:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:48 INFO - 'tests': ['damp', 'tps']}, 23:00:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:00:48 INFO - 'tests': ['dromaeo_dom']}, 23:00:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:00:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:00:48 INFO - 'tests': ['basic_compositor_video']}, 23:00:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:00:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:00:48 INFO - 'tests': ['a11yr', 23:00:48 INFO - 'ts_paint', 23:00:48 INFO - 'tpaint', 23:00:48 INFO - 'sessionrestore', 23:00:48 INFO - 'sessionrestore_no_auto_restore', 23:00:48 INFO - 'tabpaint']}, 23:00:48 INFO - 'other-e10s': {'tests': ['a11yr', 23:00:48 INFO - 'ts_paint', 23:00:48 INFO - 'tpaint', 23:00:48 INFO - 'sessionrestore', 23:00:48 INFO - 'sessionrestore_no_auto_restore', 23:00:48 INFO - 'tabpaint']}, 23:00:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:00:48 INFO - 'ts_paint', 23:00:48 INFO - 'tpaint', 23:00:48 INFO - 'sessionrestore', 23:00:48 INFO - 'sessionrestore_no_auto_restore', 23:00:48 INFO - 'tabpaint']}, 23:00:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:00:48 INFO - 'ts_paint', 23:00:48 INFO - 'tpaint', 23:00:48 INFO - 'sessionrestore', 23:00:48 INFO - 'sessionrestore_no_auto_restore', 23:00:48 INFO - 'tabpaint']}, 23:00:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:00:48 INFO - 'tests': ['a11yr', 23:00:48 INFO - 'ts_paint', 23:00:48 INFO - 'tpaint', 23:00:48 INFO - 'sessionrestore', 23:00:48 INFO - 'sessionrestore_no_auto_restore', 23:00:48 INFO - 'tabpaint']}, 23:00:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:00:48 INFO - 'tests': ['a11yr', 23:00:48 INFO - 'ts_paint', 23:00:48 INFO - 'tpaint', 23:00:48 INFO - 'sessionrestore', 23:00:48 INFO - 'sessionrestore_no_auto_restore', 23:00:48 INFO - 'tabpaint']}, 23:00:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:00:48 INFO - 'tests': ['tsvgx', 23:00:48 INFO - 'tsvgr_opacity', 23:00:48 INFO - 'tart', 23:00:48 INFO - 'tscrollx', 23:00:48 INFO - 'cart']}, 23:00:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:00:48 INFO - 'tsvgr_opacity', 23:00:48 INFO - 'tart', 23:00:48 INFO - 'tscrollx', 23:00:48 INFO - 'cart']}, 23:00:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:48 INFO - 'talos_options': ['--disable-e10s'], 23:00:48 INFO - 'tests': ['tp5o']}, 23:00:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:48 INFO - 'tests': ['tp5o']}, 23:00:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:48 INFO - 'talos_options': ['--disable-e10s', 23:00:48 INFO - '--xperf_path', 23:00:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:00:48 INFO - 'tests': ['tp5n']}, 23:00:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:00:48 INFO - 'talos_options': ['--xperf_path', 23:00:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:00:48 INFO - 'tests': ['tp5n']}}, 23:00:48 INFO - 'talos.zip': {'path': '', 23:00:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:00:48 INFO - Running post-action listener: _resource_record_post_action 23:00:48 INFO - [mozharness: 2016-08-25 06:00:48.742013Z] Finished populate-webroot step (success) 23:00:48 INFO - [mozharness: 2016-08-25 06:00:48.742101Z] Running create-virtualenv step. 23:00:48 INFO - Running pre-action listener: _resource_record_pre_action 23:00:48 INFO - Running main action method: create_virtualenv 23:00:48 INFO - Creating virtualenv /builds/slave/test/build/venv 23:00:48 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 23:00:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:00:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:00:48 INFO - Using real prefix '/usr' 23:00:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:00:49 INFO - Installing distribute.............................................................................................................................................................................................done. 23:00:51 INFO - Installing pip.................done. 23:00:51 INFO - Return code: 0 23:00:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:00: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')]} 23:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00: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')]} 23:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f1a60ac3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b85090>, '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 0x2b889b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88e40>, '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': 'a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673', '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 23:00:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 23:00:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 23:00:51 INFO - Using env: {'DISPLAY': ':0', 23:00:51 INFO - 'HOME': '/home/cltbld', 23:00:51 INFO - 'LANG': 'en_US.UTF-8', 23:00:51 INFO - 'LANGUAGE': 'en_US:en', 23:00:51 INFO - 'LOGNAME': 'cltbld', 23:00:51 INFO - 'MAIL': '/var/mail/cltbld', 23:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:51 INFO - 'MOZ_NO_REMOTE': '1', 23:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:51 INFO - 'NO_EM_RESTART': '1', 23:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:51 INFO - 'PWD': '/builds/slave/test', 23:00:51 INFO - 'SHELL': '/bin/bash', 23:00:51 INFO - 'SHLVL': '1', 23:00:51 INFO - 'TERM': 'linux', 23:00:51 INFO - 'TMOUT': '86400', 23:00:51 INFO - 'USER': 'cltbld', 23:00:51 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673', 23:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:51 INFO - '_': '/tools/buildbot/bin/python'} 23:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:51 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 23:00:51 INFO - Cleaning up... 23:00:51 INFO - Return code: 0 23:00:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:00: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')]} 23:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00: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')]} 23:00:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f1a60ac3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b85090>, '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 0x2b889b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88e40>, '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': 'a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673', '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 23:00:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 23:00:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 23:00:51 INFO - Using env: {'DISPLAY': ':0', 23:00:51 INFO - 'HOME': '/home/cltbld', 23:00:51 INFO - 'LANG': 'en_US.UTF-8', 23:00:51 INFO - 'LANGUAGE': 'en_US:en', 23:00:51 INFO - 'LOGNAME': 'cltbld', 23:00:51 INFO - 'MAIL': '/var/mail/cltbld', 23:00:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:51 INFO - 'MOZ_NO_REMOTE': '1', 23:00:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:51 INFO - 'NO_EM_RESTART': '1', 23:00:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:51 INFO - 'PWD': '/builds/slave/test', 23:00:51 INFO - 'SHELL': '/bin/bash', 23:00:51 INFO - 'SHLVL': '1', 23:00:51 INFO - 'TERM': 'linux', 23:00:51 INFO - 'TMOUT': '86400', 23:00:51 INFO - 'USER': 'cltbld', 23:00:51 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673', 23:00:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:51 INFO - '_': '/tools/buildbot/bin/python'} 23:00:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:51 INFO - Downloading/unpacking psutil>=3.1.1 23:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:00:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:00:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:00:53 INFO - Installing collected packages: psutil 23:00:53 INFO - Running setup.py install for psutil 23:00:53 INFO - building 'psutil._psutil_linux' extension 23:00:53 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 23:00:53 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 23:00:53 INFO - building 'psutil._psutil_posix' extension 23:00:53 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 23:00:54 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 23:00:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:00:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:00:54 INFO - Successfully installed psutil 23:00:54 INFO - Cleaning up... 23:00:54 INFO - Return code: 0 23:00:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:00:54 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')]} 23:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:54 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')]} 23:00:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00:54 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 0x7f1a60ac3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b85090>, '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 0x2b889b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88e40>, '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': 'a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673', '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 23:00:54 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 23:00:54 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 23:00:54 INFO - Using env: {'DISPLAY': ':0', 23:00:54 INFO - 'HOME': '/home/cltbld', 23:00:54 INFO - 'LANG': 'en_US.UTF-8', 23:00:54 INFO - 'LANGUAGE': 'en_US:en', 23:00:54 INFO - 'LOGNAME': 'cltbld', 23:00:54 INFO - 'MAIL': '/var/mail/cltbld', 23:00:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:54 INFO - 'MOZ_NO_REMOTE': '1', 23:00:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:54 INFO - 'NO_EM_RESTART': '1', 23:00:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:54 INFO - 'PWD': '/builds/slave/test', 23:00:54 INFO - 'SHELL': '/bin/bash', 23:00:54 INFO - 'SHLVL': '1', 23:00:54 INFO - 'TERM': 'linux', 23:00:54 INFO - 'TMOUT': '86400', 23:00:54 INFO - 'USER': 'cltbld', 23:00:54 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673', 23:00:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:54 INFO - '_': '/tools/buildbot/bin/python'} 23:00:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:00:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:00:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:00:56 INFO - Installing collected packages: mozsystemmonitor 23:00:56 INFO - Running setup.py install for mozsystemmonitor 23:00:56 INFO - Successfully installed mozsystemmonitor 23:00:56 INFO - Cleaning up... 23:00:56 INFO - Return code: 0 23:00:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:00: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')]} 23:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00: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')]} 23:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00: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', '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 0x7f1a60ac3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b85090>, '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 0x2b889b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88e40>, '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': 'a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673', '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 23:00: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:00: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 jsonschema==2.5.1 23:00:56 INFO - Using env: {'DISPLAY': ':0', 23:00:56 INFO - 'HOME': '/home/cltbld', 23:00:56 INFO - 'LANG': 'en_US.UTF-8', 23:00:56 INFO - 'LANGUAGE': 'en_US:en', 23:00:56 INFO - 'LOGNAME': 'cltbld', 23:00:56 INFO - 'MAIL': '/var/mail/cltbld', 23:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:56 INFO - 'MOZ_NO_REMOTE': '1', 23:00:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:56 INFO - 'NO_EM_RESTART': '1', 23:00:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:56 INFO - 'PWD': '/builds/slave/test', 23:00:56 INFO - 'SHELL': '/bin/bash', 23:00:56 INFO - 'SHLVL': '1', 23:00:56 INFO - 'TERM': 'linux', 23:00:56 INFO - 'TMOUT': '86400', 23:00:56 INFO - 'USER': 'cltbld', 23:00:56 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673', 23:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:56 INFO - '_': '/tools/buildbot/bin/python'} 23:00:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:56 INFO - Downloading/unpacking jsonschema==2.5.1 23:00: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 23:00: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 23:00: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 23:00: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 23:00: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 23:00: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 23:00:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:00:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:58 INFO - Downloading functools32-3.2.3-2.tar.gz 23:00:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:00:58 INFO - warning: no files found matching '*.txt' 23:00:58 INFO - no previously-included directories found matching 'build' 23:00:58 INFO - no previously-included directories found matching 'dist' 23:00:58 INFO - no previously-included directories found matching '.git*' 23:00:58 INFO - Installing collected packages: jsonschema, functools32 23:00:58 INFO - Running setup.py install for functools32 23:00:59 INFO - warning: no files found matching '*.txt' 23:00:59 INFO - no previously-included directories found matching 'build' 23:00:59 INFO - no previously-included directories found matching 'dist' 23:00:59 INFO - no previously-included directories found matching '.git*' 23:00:59 INFO - Successfully installed jsonschema functools32 23:00:59 INFO - Cleaning up... 23:00:59 INFO - Return code: 0 23:00:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:00: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')]} 23:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00: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')]} 23:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00: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', '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 0x7f1a60ac3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b85090>, '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 0x2b889b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88e40>, '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': 'a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673', '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 23:00: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:00: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 functools32==3.2.3-2 23:00:59 INFO - Using env: {'DISPLAY': ':0', 23:00:59 INFO - 'HOME': '/home/cltbld', 23:00:59 INFO - 'LANG': 'en_US.UTF-8', 23:00:59 INFO - 'LANGUAGE': 'en_US:en', 23:00:59 INFO - 'LOGNAME': 'cltbld', 23:00:59 INFO - 'MAIL': '/var/mail/cltbld', 23:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:59 INFO - 'MOZ_NO_REMOTE': '1', 23:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:59 INFO - 'NO_EM_RESTART': '1', 23:00:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:59 INFO - 'PWD': '/builds/slave/test', 23:00:59 INFO - 'SHELL': '/bin/bash', 23:00:59 INFO - 'SHLVL': '1', 23:00:59 INFO - 'TERM': 'linux', 23:00:59 INFO - 'TMOUT': '86400', 23:00:59 INFO - 'USER': 'cltbld', 23:00:59 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673', 23:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:59 INFO - '_': '/tools/buildbot/bin/python'} 23:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:00:59 INFO - Cleaning up... 23:00:59 INFO - Return code: 0 23:00:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:00: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')]} 23:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:00:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00: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')]} 23:00:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:00:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:00: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', '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 0x7f1a60ac3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b85090>, '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 0x2b889b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88e40>, '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': 'a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673', '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 23:00: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:00: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 blobuploader==1.2.4 23:00:59 INFO - Using env: {'DISPLAY': ':0', 23:00:59 INFO - 'HOME': '/home/cltbld', 23:00:59 INFO - 'LANG': 'en_US.UTF-8', 23:00:59 INFO - 'LANGUAGE': 'en_US:en', 23:00:59 INFO - 'LOGNAME': 'cltbld', 23:00:59 INFO - 'MAIL': '/var/mail/cltbld', 23:00:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:00:59 INFO - 'MOZ_NO_REMOTE': '1', 23:00:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:00:59 INFO - 'NO_EM_RESTART': '1', 23:00:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:00:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:00:59 INFO - 'PWD': '/builds/slave/test', 23:00:59 INFO - 'SHELL': '/bin/bash', 23:00:59 INFO - 'SHLVL': '1', 23:00:59 INFO - 'TERM': 'linux', 23:00:59 INFO - 'TMOUT': '86400', 23:00:59 INFO - 'USER': 'cltbld', 23:00:59 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673', 23:00:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:00:59 INFO - '_': '/tools/buildbot/bin/python'} 23:00:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:00:59 INFO - Downloading/unpacking blobuploader==1.2.4 23:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:00:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:00:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:00:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:01:01 INFO - Downloading blobuploader-1.2.4.tar.gz 23:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:01:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:01:01 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 23:01:01 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 23:01:01 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 23:01:01 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 23:01:01 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 23:01:01 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 23:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:01:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:01: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 23:01: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 23:01: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 23:01: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 23:01: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 23:01: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 23:01:02 INFO - Downloading docopt-0.6.1.tar.gz 23:01:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:01:02 INFO - Installing collected packages: blobuploader, requests, docopt 23:01:02 INFO - Running setup.py install for blobuploader 23:01:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:01:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:01:02 INFO - Running setup.py install for requests 23:01:02 INFO - Running setup.py install for docopt 23:01:02 INFO - Successfully installed blobuploader requests docopt 23:01:02 INFO - Cleaning up... 23:01:02 INFO - Return code: 0 23:01:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:01: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')]} 23:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01: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')]} 23:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:02 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 0x7f1a60ac3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b85090>, '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 0x2b889b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88e40>, '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': 'a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673', '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 23:01:02 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 23:01:02 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 23:01:02 INFO - Using env: {'DISPLAY': ':0', 23:01:02 INFO - 'HOME': '/home/cltbld', 23:01:02 INFO - 'LANG': 'en_US.UTF-8', 23:01:02 INFO - 'LANGUAGE': 'en_US:en', 23:01:02 INFO - 'LOGNAME': 'cltbld', 23:01:02 INFO - 'MAIL': '/var/mail/cltbld', 23:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:02 INFO - 'MOZ_NO_REMOTE': '1', 23:01:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:02 INFO - 'NO_EM_RESTART': '1', 23:01:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:02 INFO - 'PWD': '/builds/slave/test', 23:01:02 INFO - 'SHELL': '/bin/bash', 23:01:02 INFO - 'SHLVL': '1', 23:01:02 INFO - 'TERM': 'linux', 23:01:02 INFO - 'TMOUT': '86400', 23:01:02 INFO - 'USER': 'cltbld', 23:01:02 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673', 23:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:02 INFO - '_': '/tools/buildbot/bin/python'} 23:01:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:01:03 INFO - Running setup.py (path:/tmp/pip-zHujqI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:01:03 INFO - Running setup.py (path:/tmp/pip-13fjn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:01:03 INFO - Running setup.py (path:/tmp/pip-36lRKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:01:03 INFO - Running setup.py (path:/tmp/pip-Hmax6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:01:03 INFO - Running setup.py (path:/tmp/pip-V_6F_d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:01:03 INFO - Running setup.py (path:/tmp/pip-Ffz04f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:01:03 INFO - Running setup.py (path:/tmp/pip-Y8oE5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:01:03 INFO - Running setup.py (path:/tmp/pip-36jLof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:01:03 INFO - Running setup.py (path:/tmp/pip-aOyxk8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:01:03 INFO - Running setup.py (path:/tmp/pip-cr3Ncj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:01:03 INFO - Running setup.py (path:/tmp/pip-Uei_Sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:01:03 INFO - Running setup.py (path:/tmp/pip-YeoIp_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:01:04 INFO - Running setup.py (path:/tmp/pip-Vg5Lyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:01:04 INFO - Running setup.py (path:/tmp/pip-meXJ0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:01:04 INFO - Running setup.py (path:/tmp/pip-8Yb7cD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:01:04 INFO - Running setup.py (path:/tmp/pip-afspZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:01:04 INFO - Running setup.py (path:/tmp/pip-UPzMDI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:01:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:01:04 INFO - Running setup.py install for manifestparser 23:01:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:01:04 INFO - Running setup.py install for mozcrash 23:01:04 INFO - Running setup.py install for mozdebug 23:01:04 INFO - Running setup.py install for mozdevice 23:01:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:01:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:01:04 INFO - Running setup.py install for mozfile 23:01:04 INFO - Running setup.py install for mozhttpd 23:01:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:01:04 INFO - Running setup.py install for mozinfo 23:01:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:01:05 INFO - Running setup.py install for mozInstall 23:01:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:01:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:01:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:01:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:01:05 INFO - Running setup.py install for mozleak 23:01:05 INFO - Running setup.py install for mozlog 23:01:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:01:05 INFO - Running setup.py install for moznetwork 23:01:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:01:05 INFO - Running setup.py install for mozprocess 23:01:05 INFO - Running setup.py install for mozprofile 23:01:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:01:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:01:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:01:05 INFO - Running setup.py install for mozrunner 23:01:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:01:05 INFO - Running setup.py install for mozscreenshot 23:01:05 INFO - Running setup.py install for moztest 23:01:06 INFO - Running setup.py install for mozversion 23:01:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:01:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:01:06 INFO - Cleaning up... 23:01:06 INFO - Return code: 0 23:01:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:01:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:01:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:06 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 0x7f1a60ac3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b85090>, '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 0x2b889b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88e40>, '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': 'a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673', '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 23:01:06 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 23:01:06 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 23:01:06 INFO - Using env: {'DISPLAY': ':0', 23:01:06 INFO - 'HOME': '/home/cltbld', 23:01:06 INFO - 'LANG': 'en_US.UTF-8', 23:01:06 INFO - 'LANGUAGE': 'en_US:en', 23:01:06 INFO - 'LOGNAME': 'cltbld', 23:01:06 INFO - 'MAIL': '/var/mail/cltbld', 23:01:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:06 INFO - 'MOZ_NO_REMOTE': '1', 23:01:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:06 INFO - 'NO_EM_RESTART': '1', 23:01:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:06 INFO - 'PWD': '/builds/slave/test', 23:01:06 INFO - 'SHELL': '/bin/bash', 23:01:06 INFO - 'SHLVL': '1', 23:01:06 INFO - 'TERM': 'linux', 23:01:06 INFO - 'TMOUT': '86400', 23:01:06 INFO - 'USER': 'cltbld', 23:01:06 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673', 23:01:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:06 INFO - '_': '/tools/buildbot/bin/python'} 23:01:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:01:06 INFO - Running setup.py (path:/tmp/pip-kG6i76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:01:06 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)) 23:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:01:06 INFO - Running setup.py (path:/tmp/pip-qW3v4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:01:06 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)) 23:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:01:06 INFO - Running setup.py (path:/tmp/pip-IpvwKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:01:06 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)) 23:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:01:06 INFO - Running setup.py (path:/tmp/pip-eFarFd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:01:06 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)) 23:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:01:06 INFO - Running setup.py (path:/tmp/pip-PnQdPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:01:06 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)) 23:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:01:06 INFO - Running setup.py (path:/tmp/pip-n88iip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:01:06 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)) 23:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:01:06 INFO - Running setup.py (path:/tmp/pip-CtlhIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:01:06 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)) 23:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:01:06 INFO - Running setup.py (path:/tmp/pip-044XYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:01:06 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)) 23:01:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:01:06 INFO - Running setup.py (path:/tmp/pip-Hb7ug1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:01:07 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)) 23:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:01:07 INFO - Running setup.py (path:/tmp/pip-4VY_mo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:01:07 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)) 23:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:01:07 INFO - Running setup.py (path:/tmp/pip-fNT_PV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:01:07 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)) 23:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:01:07 INFO - Running setup.py (path:/tmp/pip-bAimwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:01:07 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)) 23:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:01:07 INFO - Running setup.py (path:/tmp/pip-zEV2Fd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:01:07 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)) 23:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:01:07 INFO - Running setup.py (path:/tmp/pip-D6A2CK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:01:07 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)) 23:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:01:07 INFO - Running setup.py (path:/tmp/pip-uOMm6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:01:07 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)) 23:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:01:07 INFO - Running setup.py (path:/tmp/pip-hfHtzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:01:07 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)) 23:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:01:07 INFO - Running setup.py (path:/tmp/pip-Q80dQb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:01:07 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)) 23:01:07 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)) 23:01:07 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)) 23:01:07 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)) 23:01:07 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)) 23:01:07 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)) 23:01:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:01: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 23:01: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 23:01: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 23:01: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 23:01: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 23:01: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 23:01:09 INFO - Downloading blessings-1.6.tar.gz 23:01:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:01:09 INFO - Installing collected packages: blessings 23:01:09 INFO - Running setup.py install for blessings 23:01:09 INFO - Successfully installed blessings 23:01:09 INFO - Cleaning up... 23:01:09 INFO - Return code: 0 23:01:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:01:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:01:09 INFO - Reading from file tmpfile_stdout 23:01:09 INFO - Current package versions: 23:01:09 INFO - argparse == 1.2.1 23:01:09 INFO - blessings == 1.6 23:01:09 INFO - blobuploader == 1.2.4 23:01:09 INFO - docopt == 0.6.1 23:01:09 INFO - functools32 == 3.2.3-2 23:01:09 INFO - jsonschema == 2.5.1 23:01:09 INFO - manifestparser == 1.1 23:01:09 INFO - mozInstall == 1.12 23:01:09 INFO - mozcrash == 0.17 23:01:09 INFO - mozdebug == 0.1 23:01:09 INFO - mozdevice == 0.48 23:01:09 INFO - mozfile == 1.2 23:01:09 INFO - mozhttpd == 0.7 23:01:09 INFO - mozinfo == 0.9 23:01:09 INFO - mozleak == 0.1 23:01:09 INFO - mozlog == 3.3 23:01:09 INFO - moznetwork == 0.27 23:01:09 INFO - mozprocess == 0.23 23:01:09 INFO - mozprofile == 0.28 23:01:09 INFO - mozrunner == 6.12 23:01:09 INFO - mozscreenshot == 0.1 23:01:09 INFO - mozsystemmonitor == 0.3 23:01:09 INFO - moztest == 0.7 23:01:09 INFO - mozversion == 1.4 23:01:09 INFO - psutil == 3.1.1 23:01:09 INFO - requests == 1.2.3 23:01:09 INFO - wsgiref == 0.1.2 23:01:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:01:09 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')]} 23:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:09 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')]} 23:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:09 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 0x7f1a60ac3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b85090>, '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 0x2b889b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88e40>, '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': 'a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673', '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 23:01:09 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 23:01:09 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 23:01:09 INFO - Using env: {'DISPLAY': ':0', 23:01:09 INFO - 'HOME': '/home/cltbld', 23:01:09 INFO - 'LANG': 'en_US.UTF-8', 23:01:09 INFO - 'LANGUAGE': 'en_US:en', 23:01:09 INFO - 'LOGNAME': 'cltbld', 23:01:09 INFO - 'MAIL': '/var/mail/cltbld', 23:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:09 INFO - 'MOZ_NO_REMOTE': '1', 23:01:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:09 INFO - 'NO_EM_RESTART': '1', 23:01:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:09 INFO - 'PWD': '/builds/slave/test', 23:01:09 INFO - 'SHELL': '/bin/bash', 23:01:09 INFO - 'SHLVL': '1', 23:01:09 INFO - 'TERM': 'linux', 23:01:09 INFO - 'TMOUT': '86400', 23:01:09 INFO - 'USER': 'cltbld', 23:01:09 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673', 23:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:09 INFO - '_': '/tools/buildbot/bin/python'} 23:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:10 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)) 23:01:10 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)) 23:01:10 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)) 23:01:10 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)) 23:01:10 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)) 23:01:10 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)) 23:01:10 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)) 23:01:10 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)) 23:01:10 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)) 23:01:10 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)) 23:01:10 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)) 23:01:10 INFO - Cleaning up... 23:01:10 INFO - Return code: 0 23:01:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:01:10 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')]} 23:01:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:01:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:10 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')]} 23:01:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:01:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:01:10 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 0x7f1a60ac3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2abc8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b8b230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b85090>, '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 0x2b889b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88e40>, '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': 'a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673', '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 23:01:10 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 23:01:10 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 23:01:10 INFO - Using env: {'DISPLAY': ':0', 23:01:10 INFO - 'HOME': '/home/cltbld', 23:01:10 INFO - 'LANG': 'en_US.UTF-8', 23:01:10 INFO - 'LANGUAGE': 'en_US:en', 23:01:10 INFO - 'LOGNAME': 'cltbld', 23:01:10 INFO - 'MAIL': '/var/mail/cltbld', 23:01:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:10 INFO - 'MOZ_NO_REMOTE': '1', 23:01:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:10 INFO - 'NO_EM_RESTART': '1', 23:01:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:10 INFO - 'PWD': '/builds/slave/test', 23:01:10 INFO - 'SHELL': '/bin/bash', 23:01:10 INFO - 'SHLVL': '1', 23:01:10 INFO - 'TERM': 'linux', 23:01:10 INFO - 'TMOUT': '86400', 23:01:10 INFO - 'USER': 'cltbld', 23:01:10 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673', 23:01:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:10 INFO - '_': '/tools/buildbot/bin/python'} 23:01:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:01:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:01:10 INFO - Cleaning up... 23:01:10 INFO - Return code: 0 23:01:10 INFO - Running post-action listener: _resource_record_post_action 23:01:10 INFO - Running post-action listener: _start_resource_monitoring 23:01:10 INFO - Starting resource monitoring. 23:01:10 INFO - [mozharness: 2016-08-25 06:01:10.430824Z] Finished create-virtualenv step (success) 23:01:10 INFO - [mozharness: 2016-08-25 06:01:10.431341Z] Running install step. 23:01:10 INFO - Running pre-action listener: _resource_record_pre_action 23:01:10 INFO - Running main action method: install 23:01:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:01:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:01:10 INFO - Reading from file tmpfile_stdout 23:01:10 INFO - Detecting whether we're running mozinstall >=1.0... 23:01:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:01:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:01:10 INFO - Reading from file tmpfile_stdout 23:01:10 INFO - Output received: 23:01:10 INFO - Usage: mozinstall [options] installer 23:01:10 INFO - Options: 23:01:10 INFO - -h, --help show this help message and exit 23:01:10 INFO - -d DEST, --destination=DEST 23:01:10 INFO - Directory to install application into. [default: 23:01:10 INFO - "/builds/slave/test"] 23:01:10 INFO - --app=APP Application being installed. [default: firefox] 23:01:10 INFO - mkdir: /builds/slave/test/build/application 23:01:10 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'] 23:01:10 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 23:01:26 INFO - Reading from file tmpfile_stdout 23:01:26 INFO - Output received: 23:01:26 INFO - /builds/slave/test/build/application/firefox/firefox 23:01:26 INFO - Running post-action listener: _resource_record_post_action 23:01:26 INFO - [mozharness: 2016-08-25 06:01:26.791444Z] Finished install step (success) 23:01:26 INFO - [mozharness: 2016-08-25 06:01:26.791693Z] Running run-tests step. 23:01:26 INFO - Running pre-action listener: _resource_record_pre_action 23:01:26 INFO - Running main action method: run_tests 23:01:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:01:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:01:26 INFO - Python 2.7.3 23:01:26 INFO - Return code: 0 23:01:26 INFO - grabbing minidump binary from tooltool 23:01:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:01:26 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 0x2b85090>, '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 0x2b889b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:01:26 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 23:01:26 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 23:01:26 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 23:01:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:01:26 INFO - Return code: 0 23:01:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:01:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:01:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:01:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:01:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:01:26 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/X_fQtgN6R0GX7Rye9CdejA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 23:01:26 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/X_fQtgN6R0GX7Rye9CdejA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --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 23:01:26 INFO - Using env: {'DISPLAY': ':0', 23:01:26 INFO - 'HOME': '/home/cltbld', 23:01:26 INFO - 'LANG': 'en_US.UTF-8', 23:01:26 INFO - 'LANGUAGE': 'en_US:en', 23:01:26 INFO - 'LOGNAME': 'cltbld', 23:01:26 INFO - 'MAIL': '/var/mail/cltbld', 23:01:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:01:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:01:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:01:26 INFO - 'MOZ_NO_REMOTE': '1', 23:01:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:01:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:01:26 INFO - 'NO_EM_RESTART': '1', 23:01:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:01:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:01:26 INFO - 'PWD': '/builds/slave/test', 23:01:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:01:26 INFO - 'SHELL': '/bin/bash', 23:01:26 INFO - 'SHLVL': '1', 23:01:26 INFO - 'TERM': 'linux', 23:01:26 INFO - 'TMOUT': '86400', 23:01:26 INFO - 'USER': 'cltbld', 23:01:26 INFO - 'XDG_SESSION_COOKIE': 'a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673', 23:01:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:01:26 INFO - '_': '/tools/buildbot/bin/python'} 23:01:26 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/X_fQtgN6R0GX7Rye9CdejA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--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 23:01:27 INFO - mozversion application_buildid: 20160824222726 23:01:27 INFO - mozversion application_changeset: ac729cd10150901662bbdab08f685641349fa610 23:01:27 INFO - mozversion application_display_name: Nightly 23:01:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:01:27 INFO - mozversion application_name: Firefox 23:01:27 INFO - mozversion application_remotingname: firefox 23:01:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 23:01:27 INFO - mozversion application_vendor: Mozilla 23:01:27 INFO - mozversion application_version: 51.0a1 23:01:27 INFO - mozversion platform_buildid: 20160824222726 23:01:27 INFO - mozversion platform_changeset: ac729cd10150901662bbdab08f685641349fa610 23:01:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 23:01:27 INFO - mozversion platform_version: 51.0a1 23:01:27 INFO - using testdate: 1472104887 23:01:27 INFO - actual date: 1472104887 23:01:27 INFO - starting webserver on 'localhost:44892' 23:01:27 INFO - SUITE-START | Running 2 tests 23:01:27 INFO - TEST-START | dromaeo_css 23:01:27 INFO - operating with platform_type : linux_ 23:01:27 INFO - Initialising browser for dromaeo_css test... 23:01:27 INFO - TEST-INFO | started process 7294 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKOfQHW/profile http://localhost:44892/getInfo.html) 23:01:32 INFO - PROCESS | 7294 | __metrics Screen width/height:1600/1200 23:01:32 INFO - PROCESS | 7294 | colorDepth:24 23:01:32 INFO - PROCESS | 7294 | Browser inner width/height: 1024/697 23:01:32 INFO - PROCESS | 7294 | __metrics 23:01:32 INFO - PROCESS | 7294 | 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" 23:01:32 INFO - PROCESS | 7294 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:01:33 INFO - PROCESS | 7294 | console.error: PushService: 23:01:33 INFO - PROCESS | 7294 | stateChangeProcessEnqueue: Error transitioning state 23:01:33 INFO - PROCESS | 7294 | UnknownError 23:01:33 INFO - TEST-INFO | 7294: exit 0 23:01:33 INFO - Browser initialized. 23:01:33 INFO - Running cycle 1/1 for dromaeo_css test... 23:01:33 INFO - TEST-INFO | started process 7374 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKOfQHW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:01:46 INFO - PROCESS | 7374 | RSS: Main: 181723136 23:01:46 INFO - PROCESS | 7374 | 23:02:37 INFO - PROCESS | 7374 | 1472104957006 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] 23:04:50 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:44892/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44892/tests/dromaeo/cssquery-ext.html) 23:04:51 INFO - PROCESS | 7374 | RSS: Main: 271577088 23:04:51 INFO - PROCESS | 7374 | 23:07:54 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:44892/tests/dromaeo/cssquery-ext.html (next: http://localhost:44892/tests/dromaeo/cssquery-jquery.html) 23:07:54 INFO - PROCESS | 7374 | RSS: Main: 269156352 23:07:54 INFO - PROCESS | 7374 | 23:10:56 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:44892/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44892/tests/dromaeo/cssquery-mootools.html) 23:10:57 INFO - PROCESS | 7374 | RSS: Main: 218628096 23:10:57 INFO - PROCESS | 7374 | 23:13:59 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:44892/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44892/tests/dromaeo/cssquery-prototype.html) 23:14:00 INFO - PROCESS | 7374 | RSS: Main: 228159488 23:14:00 INFO - PROCESS | 7374 | 23:17:03 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:44892/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44892/tests/dromaeo/cssquery-yui.html) 23:17:04 INFO - PROCESS | 7374 | RSS: Main: 219721728 23:17:04 INFO - PROCESS | 7374 | 23:20:07 INFO - PROCESS | 7374 | Cycle 1(1): loaded http://localhost:44892/tests/dromaeo/cssquery-yui.html (next: http://localhost:44892/tests/dromaeo/cssquery-dojo.html) 23:20:07 INFO - PROCESS | 7374 | RSS: Main: 307138560 23:20:07 INFO - PROCESS | 7374 | 23:20:07 INFO - PROCESS | 7374 | __start_tp_report 23:20:07 INFO - PROCESS | 7374 | _x_x_mozilla_page_load 23:20:07 INFO - PROCESS | 7374 | _x_x_mozilla_page_load_details 23:20:07 INFO - PROCESS | 7374 | |i|pagename|runs| 23:20:07 INFO - PROCESS | 7374 | |0;dojo.html;2580.329114430248;2588.9870550647242;2597.5454295498284;2611.399378143027;2620.5283049051163;4601.7238965662;4640.907181856365;4671.322658214557;4711.269753188257;4755.381800365952;4662.230731929228;4691.624670026398;4738.549837765416;4744.28835674649;4785.306130611059;4299;4329.718568293051;4365.192439398706;4431.512533621299;4476.992676647761;4381.75900325482;4408.537103604108;4423.491298500665;4447.866564003085;4449.510553839075;4250.08623146022;4273.358996150571;4281.48622165339;4284.65722742183;4327.6105150536605;4279.144171165748;4289.528151903288;4302.569743025703;4314.18030574193;4329.935050974238;4238.046439551107;4259.5101563319995;4308.806103725308;4311.417958575584;4318.956810431887;4657.930131048003;4719.386479757643;4735.408073990751;4744.335792988984;4762.261849413347;4855.295982082614;4889.437714662824;4914.164592019365;4987.875303117415;5052.115879721034;5078.949210507884;5091.770870310808;5093.745312734385;5097.592192624581;5104.540591346797;4764.213904705754;4767.73777442237;4772.737499437564;4812.470628230857;4824.34871292378;5018.447970723218;5066.974665126724;5152.6650767699975;5154.149565321755;5182.740862956837;4923.803047878117;4954.628402869799;4958.876028099255;4961.131801934647;5003.149464591028;5032.220005899091;5035.647504674711;5037.29477873098;5060.987802439527;5086.186210206423;4848.975755121272;4889.193283108319;4916.827911023097;4959.528844759742;4992.450830408652;4957.801687932442;4963.776630051656;4965.851024469272;5007.349044624176;5025.899482010339;4269.91460170801;4272.739541835104;4273.55127711592;4320.546342634041;4327.415798867176;3711.406175011985;3718.3307004738867;3723.2925744108534;3729.6083911189476;3799.4870692456716;4275.0381164238415;4293.463317085364;4301.139772045603;4344.47866256045;4348.804303806336;5038.874028149326;5045.772940217699;5050.242463630485;5052.115879721107;5100.030994111107;4181.581841815794;4259.254630439661;4300.1399720056115;4303.548127446636;4309.07354918694;4518.457785065813;4544.045750392388;4559.4072770539615;4603.102395032936;4620.768961551909;4768.976155119133;4770.952290477189;4772.785224664829;4774.7851346688785;4834.444038935568;4920.45874953762;5000.599952003904;5064.063148317573;5066.392032956069;5068.467810879804;4739.336492890929;4759.881002974953;4763.237881938873;4827.155247831685;4829.830955916526;4969.055879382906;4980.003999200102;4985.252212168204;4986.252062190555;5049.394072711299;4919.655624106278;4956.3804524434445;5032.27032080339;5055.3933527975405;5102.897942041064;4871.439784424837;4884.975575122102;4890.462049174659;4920.630952678492;4948.653594248368;4874.390701162355;4877.414840176886;4882.707037577757;4889.511048895082;4950.8267210647455;4730.101280756645;4812.25410061441;4814.614830813596;4823.155947709207;4875.853724388274;4919.2129259318335;4953.702777833341;4974.726390048582;5028.321176641253;5037.874053148701;4856.902861942812;4864.610831133572;4866.343043689057;4870.561649451566;4933.9013219736125 23:20:07 INFO - PROCESS | 7374 | |1;ext.html;559.253396715385;568.8663164156422;573.8077743955773;580.0776764943738;587.7325816753372;27757.306067348327;38631;39872.40191397131;39931.80034099833;43394;39284.80357598208;39868.60131398685;39909.800450997776;39958.40062399067;39959;7552.773416797491;7689.615519224017;7693.076830780315;7694.576798276093;7695.115061767912;7384.704611815521;9562.235021198323;9810.068043535854;9817.214622830157;10139.594416223343;10012.449315287657;10098.040686134842;10107.797844043114;10114.74713132174;10115.39307641544;9842.90157098427;9897.653582124663;9913.454759988197;9923.900760992407;9924.15644670204;9801.313908026441;9856.802863942681;9866.65466708669;9872.35829671069;9873;35624.28751424983;35842.82078589591;36033.279334413164;36037.63962360369;36063.4590481143;2876.367199216169;2956.674765775763;3002.369502404498;3080.768942329312;3118.70372314632;27852;28724.569131463046;29101.563476547868;29254.70745292541;29829.25426864324;3433.1073920780527;3477.930441391183;3479.321532301177;3512.332656795201;3553.502509648651;244225;246801;247201;248724;249334;49991.75004124956;50408.24387634188;50441;50463;50473.24290135651;32026.67973320237;32654.183645409055;32802.8359858204;34687.22502199818;34714.13214669603;13518.662033449242;13625.04624676283;13641.590752277447;13702.45190192401;13710.17738935667;9288.860667089999;9536.189423898908;9850.80298394028;9874.802503950024;9942.850857237147;15653;15752.684946301239;17200.913995429943;17722.20250088749;17796.55508612295;6730.192376914802;6869.725210991504;6871.725130994704;6889.968413897869;7010.831116292433;781.8514482248355;863.4171933944563;870.3385427075342;933.9486328251876;952.4142652268805;26986.865065674545;27401.725982740318;27464;27661.585076223873;28262.293442663686;882.9867551986725;919.3932004876883;1015.5277795824977;1017.3234798858824;1030.7938412317417;14643.853561464462;14741;14962.40150393972;15030.475943457503;15033.697768458846;370437;378755;378812;380582;381063;47316.5268347319;47903.28145077827;47909.52090479121;47935.520644793105;47979.760101199274;1158.6060739348661;1172.554429316854;1176.505867535637;1178.6051672689746;1179.6637958181877;25914.740852591232;27087.59368609512;27434.45131097327;27934.580981285704;28021.57967630528;41221.38167927424;41382;41461.1707765837;41484.58515414928;41543.58456415518;262656;263342;263343;263525;263790;21861.890690546446;23743;24519.38701532476;24950.875245623654;25324.366890827878;40886.79556602198;41146.58853411428;41185.38221926614;41945.79027104845;42327.15345693007;34414.48378274278;34702.82648586741;34759.304813904084;34874.30251394907;35165.824170880005;34248.31503369869;34407;34624.82687586546;34794;35172.648273516934;35034.82482587571;35339.82330088436;35456.29087418289;35598.82200589084;36457.453138202414;30942.22644433907;32890.34219315648;33115.50326745149;33123.83438082794;33853.3229335407;24855.378615534755;25231.621525677496;25279;25418.745812542376;25698.61452078183 23:20:07 INFO - PROCESS | 7374 | |2;jquery.html;363.6636111596771;369.4089456869009;371.09452934839;373.3876442634082;390.4982098004065;15688.921555392222;16843.49469515915;17005.744913826304;17014.914925425357;17093.82906170938;15822.367105315774;16704.580110690607;16786;16788.83211167888;16928.74606880895;4790.496997815231;5076.162433198518;5079.644424890259;5096.694198348093;5098.770555325001;3776.9433458498142;3918.804059797013;3944.9408258876138;3949.526056873179;5092.84721458355;5964.045752679572;6034.185384973016;6047.5766696331275;6049.153118563405;6055.303640081403;5083.542481176712;5337.4662533746705;6044.486218671396;6071.666058366788;6072.362401947798;5250.18622113573;5257.106291930381;5260.342457192851;5261.973690131563;5262.263283140325;10575.35616095976;11623.779503152131;20803.37589872306;20904.059317330757;21017.5796484071;1779.234928980538;1779.830916062972;1780.6616742818953;1791.5968906995952;1829.3322937127984;8423.536705481258;8632.13678632138;9086.409383390124;9144.634214631407;9267.76830579241;1655.7516372544094;1704.292718521812;1713.0620985010687;1713.9057351845643;1778.1376032624166;62253.68873155605;66171.66914165446;67939.3206067938;68579.31420685779;69699.30300696979;9662;9797.265205109645;9942.403455792675;10246.282760206714;10614.734631634117;13249.403776830066;13337.866621333857;13370.197788132744;13375.53185638498;13380.264085475197;6877.6217308048535;7081.504294699322;7181.06646135999;7219.819504512324;7260.782176534713;6791.2190098139345;6862.897056544156;6967.82580435483;7141.857162856818;7159.248278930637;3925.7840818755244;3928.1750832325533;3981.8606348778235;4062.878113656595;4085.20338533983;1809.6290260496567;1821.4535639308156;1836.6418548383203;1867.3650958674116;1895.109298629642;754.4492520460095;817.7342363731692;852.1776485691338;896.6996056321075;901.9864702029474;16434.67130657404;16655.41706040283;17078;17426.302947882195;17611.55971100707;798.8841617965362;808.1554775259867;809.5426084262491;813.9959300203461;827.4952279109739;9230.907690923004;9265.583048762823;9730.659426920023;9777.168940639984;9800.754981125529;276138;279281;279675;374754;381740;47381.52618473771;47993.76081109433;81997.59001205076;82991.58504207562;83178.58410707908;922.524899676667;946.2240962410895;948.7011591348703;955;967.6516454076527;15661.361909712723;15776.053436793829;15819.762703559685;16179.352825886832;16582.75125873089;36758.816205919866;36938.261234775695;37317.4402383959;38006.65840586435;39915;50394.7480262611;50606.49393506165;50758.746206268734;52239.73880130575;53036;6905.827354316182;7054.118235220598;7170.784876453715;7364.153122390993;7575.393968482398;10995.945020274847;11105.888941110808;11116.333020018825;11155.944220278847;11336.773264534828;9072.546372681472;9902.356346837432;9915.752106197402;10279.074883260542;10454.372737635766;10301;10359.32664376813;10432.165426765689;10587.735306617396;11102.722431939266;10056.19550435978;10303.948480257552;10463.790724185626;10515.894841051491;10801.189910756882;7152.463565232524;7209.855802884018;7265.62810475706;7523.811904702427;7527.247275272429;9036.186743193144;9871.160951319218;9981.45102019396;10251.538680759533;10287.897121028695 23:20:07 INFO - PROCESS | 7374 | |3;mootools.html;1257.490716259915;1353.844307904591;1382.7925811128332;1436.360819435351;1644.7089035107435;6637.701303441345;7347.88978165328;7621;7627.427942904291;7800.219978002211;7635.121960974489;7680.039995000625;7691.6154192290305;7692.9230707692905;7694.153643099255;2116.2698868890284;2131.8081372676456;2134.5165110248386;2135.2313167259854;2147.1518750093705;2078.2206672497814;2123.5859007493546;2141.486043349593;2144.5603651251454;2151.0857885398723;2078.968815467769;2089.300084471704;2101.2645574049116;2102.926397576085;2139.229877244191;2055.0033233881554;2057.40335302762;2060.2994981706292;2063.9071241794154;2065.3597384810755;2065.3597384810605;2126.1070350452846;2126.670366093258;2129.99890051677;2132.424245453719;7606.6196690165825;7645.808854778619;7675.232476752336;7783.961080194619;7787.727429539939;4354.521002689701;4521.253993091136;4532.3201519771965;4536.977315113436;4540.614047805941;2807.9719202807914;2934.369110641201;2981.7465515431213;2996.580478732979;3002.879884804627;923.1922068190333;927.7958849053198;929.4794914847707;932.6176267730266;953.3707752883064;10004.349717268355;10058.245631577662;10082.596696132146;10105.938876417944;10122.797544049152;3947.1513624570857;4014.8594799181888;4098.5286692030795;4099.692523060782;4226.704130710821;8152.510849349058;8330.375221858385;8333.083360830304;8344.707935222359;8349.95825020871;4453.198424283595;4458.06380660065;4459.3979812724865;4460.420145381079;4462.352958820953;3563.768355056913;3952.8418863245147;4078.3678529827926;4100.876973690794;4114.547399786021;3165.8100513969234;3191.9042428727175;3303.735701143951;3312.0726196664973;3328.5340052392685;938.3244064273712;938.6245501799199;945.1163162443138;946.8437707778277;954.0268925695751;822.153182222312;830.8836762853206;845.8758587824232;851.476342049635;853.6756032707532;5036.118679231193;5132.626060784272;5139.434662187156;5182.486494050382;5269;383.4746397435531;389.34395543509277;398.6013986013986;404.62167873038806;404.63784912503144;3547.035584937059;3657.140571965586;3704;3712.3874560697723;3801.82891769871;9148.725538233864;9589.472579008081;9591;9604.135627793532;9686.515674216262;9390.718278451657;9439.716808495756;9509.524523773784;9513.714588562354;9551.331406801457;7002.894956575554;7118.679659415338;7151.499395042297;7180.820479488055;7214.891776623354;4920.36035315421;4957.876053098701;5045.066662667418;5092.439831618593;5289.2330612061805;8248.10293632456;8488.278496327881;8522.829543408972;8573.18554737299;8632.136786321318;8538.487690738575;8918.598663060047;8953.343631427946;9017;9048.773780655536;6072.392760724069;6538.215414150332;6747.2915343890145;6844;6889.793306200822;7251.673674684757;7551.773446796605;7570.129435114812;7571.507851989823;7574.394048475999;6499;6518.250401203923;6664.966675166787;6703.832404189934;6786.898196526958;6507.6746162692625;6508.934910651023;6568.080468734476;6604.735810567716;6609.272979972103;6339.429451349401;6409.455196308366;6426.710798014195;6452.838679033061;6467.12453388512;4631.351610774562;4639.2113340731485;4716.481187069488;4759.214729569582;4819.3252944588485;4577.679562430598;4652.55800698933;4658.976705116588;4677.345171676036;4919.975400122977 23:20:07 INFO - PROCESS | 7374 | |4;prototype.html;285.79565610588423;292.76139945944055;297.4215151530274;298.08933707523505;304.7242245767581;4693.249080147177;4846.110017093332;4864.173090574602;4888.902221955564;4902.289168070628;4647.721136731799;4781.856544303677;4810.350602668639;4819.421669399668;4819.975900120495;3817.236552689459;3822.2355528894195;3833.4249862520564;3837.1558257183374;3837.9232415351676;3601.2617413430185;3655;3846.1346197105568;3879.70902182336;3886.261610294049;3792.355299599075;3807.9428808567895;3809.9141744602794;3812.82842272097;3816.4466152407886;3792.981035094807;3797.259534390795;3809.8285577148954;3826.9808650956847;3827.4832897558754;3367.0235631667033;3371.679690429405;3376.57792775903;3394.7114495267933;3397.4903764435285;4546.840860569864;4686.7656617169005;4708.340832283483;4719.952800471986;4762.737699592701;4333.06839029607;4342.457192850894;4348.760818155;4351.998080882798;4370.077166046929;5019.247112933052;5053.8231161909525;5069.493050694938;5095.757866538711;5112.718800465973;3595.01137187273;3689.1330537323706;3691.483192353073;3715.516982792247;3724.7020238380865;5214.739263036833;5245.580353571705;5248.396434410053;5249.4488078751565;5262.342362155909;3759.6240375962184;3762.2663580602066;3763.8357944182203;3774.75464094833;3782.3380908340932;3844.788536630512;3850.441685955521;3851.441540976543;3855.51806024247;3857.787821669779;4134.896627584274;4284.700070995001;4289.970407102273;4325.091730736518;4334.591257841214;5018.974905125451;5022.196448568285;5026.547610715053;5042.899142017139;5050.545450909436;1252.2173641474078;1280.1934781088041;1310.28589418767;1312.2651315263483;1331.161368337941;881.5151666583354;898.6225785170244;914.1772404835568;916.5829547555846;916.8670542771395;4352.932357130338;4362.825486980549;4387.36383224437;4413.249747542925;4417.182821178092;5125.461826508237;5132.974335128375;5137.768800403991;5144.176931690911;5153.2785410042625;4377.9124417511475;4384.539623339567;4404.2512772828695;4415.933760993587;4416.690831641754;2317.8145748340094;2423.515296940619;2425.6604075429454;2432.795766095794;2435.4276744965273;4312.223799716081;4337.566243375637;4339.414179085783;4346.956530434719;4350.543192964757;4646.5353464653945;4657.69724967876;4675.485696573374;4675.807669044372;4698.2952557116705;4150.584941505826;4295.634871035934;4328.502222244482;4329.978350108229;4350.825966961286;4543.477934891848;4555.724397168798;4557.5442455754155;4575.512958288636;4585.372192871482;4485.955140448554;4497.707649002804;4507.940633951084;4519.751413672279;4543.522930092425;4009.9975006248437;4294.549072347359;4342.523541995736;4344.283193273074;4360.847370342023;3410.9829450852585;3421.26442814796;3424.2637832866053;3426.7429942753893;3439.570053743282;4521.683482156218;4540.273556230987;4571.519990401093;4591.117641766859;4889.242167464049;4818.855434336975;5031.295618613324;5033.723145227048;5038.2190760432195;5039.622028347815;5001.199568155534;5004.474530174425;5014.648974571745;5033;5047.425812835407;4849.684770489906;4958.652894297365;4963.900721985612;4970.950290497193;4989.875253118701;5035.093683137071;5045.772940217773;5058.747062646927;5089.51649593288;5090.541851233407;4920.975395123001;4953.331300274417;4961.950380496293;4967.329410529533;4973.030259099441 23:20:07 INFO - PROCESS | 7374 | |5;yui.html;603.261005268546;613.7544982007197;659.6833519910446;695.7808290388531;717.0749732844631;12874.227546347214;13201.867981320196;14082.929585352073;14652.26738663068;14678.486252981147;13646;14017.229052402114;14090.436382544685;14097.365618547165;14190.574282771533;625.8466675664446;753.2768542199495;771.9768406947773;774.570113586959;775.8099265679916;747.0960138232745;768.9461737678365;770.4606775257314;785.7053604898164;786.8504984053012;810.9837803243931;814.5886327404652;816.0900595835631;816.9387295952797;817.0971076959963;650.3626446082818;815.0179034263728;816.4774544291658;817.1868990354576;817.207308910359;574.5087949802942;588.7115313496356;590.0853676800941;592.8873514032321;593.1192179613271;12965.481380744759;13039.478420863154;13050.086493945428;13063.542776002794;13208.405621746948;12468.189567678071;13216.207027578375;13384.86615133846;13490.730185396236;13537.323133843367;11653.242539235007;11755.588554400554;11896.940515297454;11940.283582985048;12656.493740250471;4196.559361267054;4258.041940563379;4265.786710664485;4276.358546218092;4306.354046892991;64429;65338;65352;65416;66009.66995165042;10780.29928054674;11137.05335046514;11174.27367221128;11219.1585631078;11223.55105795759;20062.49843753918;20109.899450502653;20115;20149.39551813448;20195.394138175878;6287.2140982377205;6512.218533775977;6651.135352404156;6760.7295708172105;6835.14560679915;3719.9070023249637;3740.551133863954;3743.4010558311084;3777.6788972937056;3861.5945325740954;2899.275181204699;3030.8939187128344;3034.543419158816;3038.2404398900276;3041.8935337263533;508.74054232341774;510.49716029710703;511.4348644747575;511.4476365525224;522.8326935380642;426.6650679216862;469.59380136181954;520.8125074973007;528.6510902804208;540.0656863625949;7593.139680778245;7745.728899488491;7835.373170146375;7933.484323518953;7942;532.5287120898033;539.2558269588022;539.9298091248113;567.7700531284754;582.6009183709173;3504.3867323218333;3775.2826962876966;3791.4881490998914;3872.6127387261613;3889.202713443737;57708.71145644329;67341.66329168323;95820;108238;108563.45718271358;53912.913063040854;84445;85188.14811851802;85671.5716421414;85715;47349.28976065362;48876.511234887905;75705.62147189229;78256;78883;7136.393406560501;7154.642267886481;7275.854482910418;7280.96359518199;7457.067866516685;48433.515664842904;48468;49111;49479.50520494749;50826.745866271915;65431;71178.28821711717;71514.64242678753;72168;73497;10304.072633463024;10690.62582809598;10941.781164376509;11123.944380278046;11670.299782013106;12461.626151215478;12497.18768280059;12908.290044047291;12956.28740419286;13600.86399135996;11623.418829058344;12095.395230238277;12349.135560511037;12517.624471265877;12658.303793291458;11137.164712646421;11488.080953523866;11490.138239631893;11607.187496875475;12194.329311887932;10800.837987430352;11286.830697539708;11318.26431281964;11408.600698975828;11582.826257605973;9484.099010594258;9575.664851730435;9619.615215391586;9627.711168664951;9711;9830.459324737209;10121.190304775748;10196.133328667147;10215;10271.640492582725 23:20:07 INFO - PROCESS | 7374 | __end_tp_report 23:20:07 INFO - PROCESS | 7374 | __start_cc_report 23:20:07 INFO - PROCESS | 7374 | _x_x_mozilla_cycle_collect,988 23:20:07 INFO - PROCESS | 7374 | __end_cc_report 23:20:07 INFO - PROCESS | 7374 | __startTimestamp1472106007489__endTimestamp 23:20:07 INFO - PROCESS | 7374 | 23:20:07 INFO - PROCESS | 7374 | ------- Summary: start ------- 23:20:07 INFO - PROCESS | 7374 | Number of tests: 6 23:20:07 INFO - PROCESS | 7374 | 23:20:07 INFO - PROCESS | 7374 | [#0] dojo.html Cycles:165 Average:4653.42 Median:4812.47 stddev:489.71 (10.2%) stddev-sans-first:463.42 23:20:07 INFO - PROCESS | 7374 | Values: 2580.3 2589.0 2597.5 2611.4 2620.5 4601.7 4640.9 4671.3 4711.3 4755.4 4662.2 4691.6 4738.5 4744.3 4785.3 4299.0 4329.7 4365.2 4431.5 4477.0 4381.8 4408.5 4423.5 4447.9 4449.5 4250.1 4273.4 4281.5 4284.7 4327.6 4279.1 4289.5 4302.6 4314.2 4329.9 4238.0 4259.5 4308.8 4311.4 4319.0 4657.9 4719.4 4735.4 4744.3 4762.3 4855.3 4889.4 4914.2 4987.9 5052.1 5078.9 5091.8 5093.7 5097.6 5104.5 4764.2 4767.7 4772.7 4812.5 4824.3 5018.4 5067.0 5152.7 5154.1 5182.7 4923.8 4954.6 4958.9 4961.1 5003.1 5032.2 5035.6 5037.3 5061.0 5086.2 4849.0 4889.2 4916.8 4959.5 4992.5 4957.8 4963.8 4965.9 5007.3 5025.9 4269.9 4272.7 4273.6 4320.5 4327.4 3711.4 3718.3 3723.3 3729.6 3799.5 4275.0 4293.5 4301.1 4344.5 4348.8 5038.9 5045.8 5050.2 5052.1 5100.0 4181.6 4259.3 4300.1 4303.5 4309.1 4518.5 4544.0 4559.4 4603.1 4620.8 4769.0 4771.0 4772.8 4774.8 4834.4 4920.5 5000.6 5064.1 5066.4 5068.5 4739.3 4759.9 4763.2 4827.2 4829.8 4969.1 4980.0 4985.3 4986.3 5049.4 4919.7 4956.4 5032.3 5055.4 5102.9 4871.4 4885.0 4890.5 4920.6 4948.7 4874.4 4877.4 4882.7 4889.5 4950.8 4730.1 4812.3 4814.6 4823.2 4875.9 4919.2 4953.7 4974.7 5028.3 5037.9 4856.9 4864.6 4866.3 4870.6 4933.9 23:20:07 INFO - PROCESS | 7374 | 23:20:07 INFO - PROCESS | 7374 | [#1] ext.html Cycles:180 Average:44623.31 Median:34954.56 stddev:79273.37 (226.8%) stddev-sans-first:79426.72 23:20:07 INFO - PROCESS | 7374 | Values: 559.3 568.9 573.8 580.1 587.7 27757.3 38631.0 39872.4 39931.8 43394.0 39284.8 39868.6 39909.8 39958.4 39959.0 7552.8 7689.6 7693.1 7694.6 7695.1 7384.7 9562.2 9810.1 9817.2 10139.6 10012.4 10098.0 10107.8 10114.7 10115.4 9842.9 9897.7 9913.5 9923.9 9924.2 9801.3 9856.8 9866.7 9872.4 9873.0 35624.3 35842.8 36033.3 36037.6 36063.5 2876.4 2956.7 3002.4 3080.8 3118.7 27852.0 28724.6 29101.6 29254.7 29829.3 3433.1 3477.9 3479.3 3512.3 3553.5 244225.0 246801.0 247201.0 248724.0 249334.0 49991.8 50408.2 50441.0 50463.0 50473.2 32026.7 32654.2 32802.8 34687.2 34714.1 13518.7 13625.0 13641.6 13702.5 13710.2 9288.9 9536.2 9850.8 9874.8 9942.9 15653.0 15752.7 17200.9 17722.2 17796.6 6730.2 6869.7 6871.7 6890.0 7010.8 781.9 863.4 870.3 933.9 952.4 26986.9 27401.7 27464.0 27661.6 28262.3 883.0 919.4 1015.5 1017.3 1030.8 14643.9 14741.0 14962.4 15030.5 15033.7 370437.0 378755.0 378812.0 380582.0 381063.0 47316.5 47903.3 47909.5 47935.5 47979.8 1158.6 1172.6 1176.5 1178.6 1179.7 25914.7 27087.6 27434.5 27934.6 28021.6 41221.4 41382.0 41461.2 41484.6 41543.6 262656.0 263342.0 263343.0 263525.0 263790.0 21861.9 23743.0 24519.4 24950.9 25324.4 40886.8 41146.6 41185.4 41945.8 42327.2 34414.5 34702.8 34759.3 34874.3 35165.8 34248.3 34407.0 34624.8 34794.0 35172.6 35034.8 35339.8 35456.3 35598.8 36457.5 30942.2 32890.3 33115.5 33123.8 33853.3 24855.4 25231.6 25279.0 25418.7 25698.6 23:20:07 INFO - PROCESS | 7374 | 23:20:07 INFO - PROCESS | 7374 | [#2] jquery.html Cycles:180 Average:21874.41 Median:26086.01 stddev:53600.80 (205.5%) stddev-sans-first:53726.83 23:20:07 INFO - PROCESS | 7374 | Values: 363.7 369.4 371.1 373.4 390.5 15688.9 16843.5 17005.7 17014.9 17093.8 15822.4 16704.6 16786.0 16788.8 16928.7 4790.5 5076.2 5079.6 5096.7 5098.8 3776.9 3918.8 3944.9 3949.5 5092.8 5964.0 6034.2 6047.6 6049.2 6055.3 5083.5 5337.5 6044.5 6071.7 6072.4 5250.2 5257.1 5260.3 5262.0 5262.3 10575.4 11623.8 20803.4 20904.1 21017.6 1779.2 1779.8 1780.7 1791.6 1829.3 8423.5 8632.1 9086.4 9144.6 9267.8 1655.8 1704.3 1713.1 1713.9 1778.1 62253.7 66171.7 67939.3 68579.3 69699.3 9662.0 9797.3 9942.4 10246.3 10614.7 13249.4 13337.9 13370.2 13375.5 13380.3 6877.6 7081.5 7181.1 7219.8 7260.8 6791.2 6862.9 6967.8 7141.9 7159.2 3925.8 3928.2 3981.9 4062.9 4085.2 1809.6 1821.5 1836.6 1867.4 1895.1 754.4 817.7 852.2 896.7 902.0 16434.7 16655.4 17078.0 17426.3 17611.6 798.9 808.2 809.5 814.0 827.5 9230.9 9265.6 9730.7 9777.2 9800.8 276138.0 279281.0 279675.0 374754.0 381740.0 47381.5 47993.8 81997.6 82991.6 83178.6 922.5 946.2 948.7 955.0 967.7 15661.4 15776.1 15819.8 16179.4 16582.8 36758.8 36938.3 37317.4 38006.7 39915.0 50394.7 50606.5 50758.7 52239.7 53036.0 6905.8 7054.1 7170.8 7364.2 7575.4 10995.9 11105.9 11116.3 11155.9 11336.8 9072.5 9902.4 9915.8 10279.1 10454.4 10301.0 10359.3 10432.2 10587.7 11102.7 10056.2 10303.9 10463.8 10515.9 10801.2 7152.5 7209.9 7265.6 7523.8 7527.2 9036.2 9871.2 9981.5 10251.5 10287.9 23:20:07 INFO - PROCESS | 7374 | 23:20:07 INFO - PROCESS | 7374 | [#3] mootools.html Cycles:180 Average:5000.07 Median:5136.03 stddev:2815.25 (54.8%) stddev-sans-first:2809.10 23:20:07 INFO - PROCESS | 7374 | Values: 1257.5 1353.8 1382.8 1436.4 1644.7 6637.7 7347.9 7621.0 7627.4 7800.2 7635.1 7680.0 7691.6 7692.9 7694.2 2116.3 2131.8 2134.5 2135.2 2147.2 2078.2 2123.6 2141.5 2144.6 2151.1 2079.0 2089.3 2101.3 2102.9 2139.2 2055.0 2057.4 2060.3 2063.9 2065.4 2065.4 2126.1 2126.7 2130.0 2132.4 7606.6 7645.8 7675.2 7784.0 7787.7 4354.5 4521.3 4532.3 4537.0 4540.6 2808.0 2934.4 2981.7 2996.6 3002.9 923.2 927.8 929.5 932.6 953.4 10004.3 10058.2 10082.6 10105.9 10122.8 3947.2 4014.9 4098.5 4099.7 4226.7 8152.5 8330.4 8333.1 8344.7 8350.0 4453.2 4458.1 4459.4 4460.4 4462.4 3563.8 3952.8 4078.4 4100.9 4114.5 3165.8 3191.9 3303.7 3312.1 3328.5 938.3 938.6 945.1 946.8 954.0 822.2 830.9 845.9 851.5 853.7 5036.1 5132.6 5139.4 5182.5 5269.0 383.5 389.3 398.6 404.6 404.6 3547.0 3657.1 3704.0 3712.4 3801.8 9148.7 9589.5 9591.0 9604.1 9686.5 9390.7 9439.7 9509.5 9513.7 9551.3 7002.9 7118.7 7151.5 7180.8 7214.9 4920.4 4957.9 5045.1 5092.4 5289.2 8248.1 8488.3 8522.8 8573.2 8632.1 8538.5 8918.6 8953.3 9017.0 9048.8 6072.4 6538.2 6747.3 6844.0 6889.8 7251.7 7551.8 7570.1 7571.5 7574.4 6499.0 6518.3 6665.0 6703.8 6786.9 6507.7 6508.9 6568.1 6604.7 6609.3 6339.4 6409.5 6426.7 6452.8 6467.1 4631.4 4639.2 4716.5 4759.2 4819.3 4577.7 4652.6 4659.0 4677.3 4920.0 23:20:07 INFO - PROCESS | 7374 | 23:20:07 INFO - PROCESS | 7374 | [#4] prototype.html Cycles:180 Average:4074.37 Median:4408.75 stddev:1158.77 (26.3%) stddev-sans-first:1126.59 23:20:07 INFO - PROCESS | 7374 | Values: 285.8 292.8 297.4 298.1 304.7 4693.2 4846.1 4864.2 4888.9 4902.3 4647.7 4781.9 4810.4 4819.4 4820.0 3817.2 3822.2 3833.4 3837.2 3837.9 3601.3 3655.0 3846.1 3879.7 3886.3 3792.4 3807.9 3809.9 3812.8 3816.4 3793.0 3797.3 3809.8 3827.0 3827.5 3367.0 3371.7 3376.6 3394.7 3397.5 4546.8 4686.8 4708.3 4720.0 4762.7 4333.1 4342.5 4348.8 4352.0 4370.1 5019.2 5053.8 5069.5 5095.8 5112.7 3595.0 3689.1 3691.5 3715.5 3724.7 5214.7 5245.6 5248.4 5249.4 5262.3 3759.6 3762.3 3763.8 3774.8 3782.3 3844.8 3850.4 3851.4 3855.5 3857.8 4134.9 4284.7 4290.0 4325.1 4334.6 5019.0 5022.2 5026.5 5042.9 5050.5 1252.2 1280.2 1310.3 1312.3 1331.2 881.5 898.6 914.2 916.6 916.9 4352.9 4362.8 4387.4 4413.2 4417.2 5125.5 5133.0 5137.8 5144.2 5153.3 4377.9 4384.5 4404.3 4415.9 4416.7 2317.8 2423.5 2425.7 2432.8 2435.4 4312.2 4337.6 4339.4 4347.0 4350.5 4646.5 4657.7 4675.5 4675.8 4698.3 4150.6 4295.6 4328.5 4330.0 4350.8 4543.5 4555.7 4557.5 4575.5 4585.4 4486.0 4497.7 4507.9 4519.8 4543.5 4010.0 4294.5 4342.5 4344.3 4360.8 3411.0 3421.3 3424.3 3426.7 3439.6 4521.7 4540.3 4571.5 4591.1 4889.2 4818.9 5031.3 5033.7 5038.2 5039.6 5001.2 5004.5 5014.6 5033.0 5047.4 4849.7 4958.7 4963.9 4971.0 4989.9 5035.1 5045.8 5058.7 5089.5 5090.5 4921.0 4953.3 4962.0 4967.3 4973.0 23:20:07 INFO - PROCESS | 7374 | 23:20:07 INFO - PROCESS | 7374 | [#5] yui.html Cycles:180 Average:17670.76 Median:48672.26 stddev:24807.42 (51.0%) stddev-sans-first:24843.91 23:20:07 INFO - PROCESS | 7374 | Values: 603.3 613.8 659.7 695.8 717.1 12874.2 13201.9 14082.9 14652.3 14678.5 13646.0 14017.2 14090.4 14097.4 14190.6 625.8 753.3 772.0 774.6 775.8 747.1 768.9 770.5 785.7 786.9 811.0 814.6 816.1 816.9 817.1 650.4 815.0 816.5 817.2 817.2 574.5 588.7 590.1 592.9 593.1 12965.5 13039.5 13050.1 13063.5 13208.4 12468.2 13216.2 13384.9 13490.7 13537.3 11653.2 11755.6 11896.9 11940.3 12656.5 4196.6 4258.0 4265.8 4276.4 4306.4 64429.0 65338.0 65352.0 65416.0 66009.7 10780.3 11137.1 11174.3 11219.2 11223.6 20062.5 20109.9 20115.0 20149.4 20195.4 6287.2 6512.2 6651.1 6760.7 6835.1 3719.9 3740.6 3743.4 3777.7 3861.6 2899.3 3030.9 3034.5 3038.2 3041.9 508.7 510.5 511.4 511.4 522.8 426.7 469.6 520.8 528.7 540.1 7593.1 7745.7 7835.4 7933.5 7942.0 532.5 539.3 539.9 567.8 582.6 3504.4 3775.3 3791.5 3872.6 3889.2 57708.7 67341.7 95820.0 108238.0 108563.5 53912.9 84445.0 85188.1 85671.6 85715.0 47349.3 48876.5 75705.6 78256.0 78883.0 7136.4 7154.6 7275.9 7281.0 7457.1 48433.5 48468.0 49111.0 49479.5 50826.7 65431.0 71178.3 71514.6 72168.0 73497.0 10304.1 10690.6 10941.8 11123.9 11670.3 12461.6 12497.2 12908.3 12956.3 13600.9 11623.4 12095.4 12349.1 12517.6 12658.3 11137.2 11488.1 11490.1 11607.2 12194.3 10800.8 11286.8 11318.3 11408.6 11582.8 9484.1 9575.7 9619.6 9627.7 9711.0 9830.5 10121.2 10196.1 10215.0 10271.6 23:20:07 INFO - PROCESS | 7374 | -------- Summary: end -------- 23:20:07 INFO - PROCESS | 7374 | 23:20:08 INFO - TEST-INFO | 7374: exit 0 23:20:08 INFO - TEST-OK | dromaeo_css | took 1121421ms 23:20:08 INFO - TEST-START | kraken 23:20:08 INFO - operating with platform_type : linux_ 23:20:08 INFO - Initialising browser for kraken test... 23:20:08 INFO - TEST-INFO | started process 7680 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoj3XFa/profile http://localhost:44892/getInfo.html) 23:20:12 INFO - PROCESS | 7680 | __metrics Screen width/height:1600/1200 23:20:12 INFO - PROCESS | 7680 | colorDepth:24 23:20:12 INFO - PROCESS | 7680 | Browser inner width/height: 1024/697 23:20:12 INFO - PROCESS | 7680 | __metrics 23:20:13 INFO - PROCESS | 7680 | 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" 23:20:13 INFO - PROCESS | 7680 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:20:14 INFO - TEST-INFO | 7680: exit 0 23:20:14 INFO - Browser initialized. 23:20:14 INFO - Running cycle 1/1 for kraken test... 23:20:14 INFO - TEST-INFO | started process 7758 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpoj3XFa/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:20:26 INFO - PROCESS | 7758 | RSS: Main: 181764096 23:20:26 INFO - PROCESS | 7758 | 23:20:29 INFO - PROCESS | 7758 | Cycle 1(1): loaded http://localhost:44892/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44892/tests/kraken/driver.html?testName=audio-beat-detection) 23:20:30 INFO - PROCESS | 7758 | RSS: Main: 235319296 23:20:30 INFO - PROCESS | 7758 | 23:20:33 INFO - PROCESS | 7758 | Cycle 1(1): loaded http://localhost:44892/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44892/tests/kraken/driver.html?testName=audio-dft) 23:20:33 INFO - PROCESS | 7758 | RSS: Main: 225878016 23:20:33 INFO - PROCESS | 7758 | 23:20:37 INFO - PROCESS | 7758 | Cycle 1(1): loaded http://localhost:44892/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44892/tests/kraken/driver.html?testName=audio-fft) 23:20:37 INFO - PROCESS | 7758 | RSS: Main: 303292416 23:20:37 INFO - PROCESS | 7758 | 23:20:39 INFO - PROCESS | 7758 | Cycle 1(1): loaded http://localhost:44892/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44892/tests/kraken/driver.html?testName=audio-oscillator) 23:20:40 INFO - PROCESS | 7758 | RSS: Main: 213553152 23:20:40 INFO - PROCESS | 7758 | 23:20:42 INFO - PROCESS | 7758 | Cycle 1(1): loaded http://localhost:44892/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44892/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:20:43 INFO - PROCESS | 7758 | RSS: Main: 216920064 23:20:43 INFO - PROCESS | 7758 | 23:20:46 INFO - PROCESS | 7758 | Cycle 1(1): loaded http://localhost:44892/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44892/tests/kraken/driver.html?testName=imaging-darkroom) 23:20:47 INFO - PROCESS | 7758 | RSS: Main: 255721472 23:20:47 INFO - PROCESS | 7758 | 23:20:50 INFO - PROCESS | 7758 | Cycle 1(1): loaded http://localhost:44892/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44892/tests/kraken/driver.html?testName=imaging-desaturate) 23:20:51 INFO - PROCESS | 7758 | RSS: Main: 249556992 23:20:51 INFO - PROCESS | 7758 | 23:20:54 INFO - PROCESS | 7758 | Cycle 1(1): loaded http://localhost:44892/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44892/tests/kraken/driver.html?testName=json-parse-financial) 23:20:54 INFO - PROCESS | 7758 | RSS: Main: 253087744 23:20:54 INFO - PROCESS | 7758 | 23:20:56 INFO - PROCESS | 7758 | Cycle 1(1): loaded http://localhost:44892/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44892/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:20:57 INFO - PROCESS | 7758 | RSS: Main: 216985600 23:20:57 INFO - PROCESS | 7758 | 23:20:58 INFO - PROCESS | 7758 | Cycle 1(1): loaded http://localhost:44892/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44892/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:20:59 INFO - PROCESS | 7758 | RSS: Main: 224006144 23:20:59 INFO - PROCESS | 7758 | 23:21:01 INFO - PROCESS | 7758 | Cycle 1(1): loaded http://localhost:44892/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44892/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:21:02 INFO - PROCESS | 7758 | RSS: Main: 223748096 23:21:02 INFO - PROCESS | 7758 | 23:21:05 INFO - PROCESS | 7758 | Cycle 1(1): loaded http://localhost:44892/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44892/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:21:05 INFO - PROCESS | 7758 | RSS: Main: 218136576 23:21:05 INFO - PROCESS | 7758 | 23:21:08 INFO - PROCESS | 7758 | Cycle 1(1): loaded http://localhost:44892/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44892/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:21:09 INFO - PROCESS | 7758 | RSS: Main: 221687808 23:21:09 INFO - PROCESS | 7758 | 23:21:11 INFO - PROCESS | 7758 | Cycle 1(1): loaded http://localhost:44892/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44892/tests/kraken/driver.html?testName=ai-astar) 23:21:11 INFO - PROCESS | 7758 | RSS: Main: 271810560 23:21:11 INFO - PROCESS | 7758 | 23:21:11 INFO - PROCESS | 7758 | __start_tp_report 23:21:11 INFO - PROCESS | 7758 | _x_x_mozilla_page_load 23:21:11 INFO - PROCESS | 7758 | _x_x_mozilla_page_load_details 23:21:11 INFO - PROCESS | 7758 | |i|pagename|runs| 23:21:11 INFO - PROCESS | 7758 | |0;ai-astar;117;115;129;118;114;114;114;113;115;116 23:21:11 INFO - PROCESS | 7758 | |1;audio-beat-detection;163;121;151;202;128;145;144;123;181;123 23:21:11 INFO - PROCESS | 7758 | |2;audio-dft;161;160;161;159;162;161;162;162;159;161 23:21:11 INFO - PROCESS | 7758 | |3;audio-fft;75;75;74;169;77;76;77;77;164;75 23:21:11 INFO - PROCESS | 7758 | |4;audio-oscillator;86;86;147;86;86;86;156;88;87;144 23:21:11 INFO - PROCESS | 7758 | |5;imaging-gaussian-blur;117;117;117;117;116;117;116;116;117;117 23:21:11 INFO - PROCESS | 7758 | |6;imaging-darkroom;147;147;147;148;147;147;147;146;147;147 23:21:11 INFO - PROCESS | 7758 | |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 23:21:11 INFO - PROCESS | 7758 | |8;json-parse-financial;66;67;65;67;66;68;66;68;65;66 23:21:11 INFO - PROCESS | 7758 | |9;json-stringify-tinderbox;64;65;65;66;66;65;67;66;66;66 23:21:11 INFO - PROCESS | 7758 | |10;stanford-crypto-aes;82;83;83;82;86;84;83;83;92;86 23:21:11 INFO - PROCESS | 7758 | |11;stanford-crypto-ccm;141;144;132;134;131;131;129;131;148;133 23:21:11 INFO - PROCESS | 7758 | |12;stanford-crypto-pbkdf2;171;173;173;177;171;177;174;176;175;171 23:21:11 INFO - PROCESS | 7758 | |13;stanford-crypto-sha256-iterative;70;68;74;69;68;69;67;68;71;69 23:21:11 INFO - PROCESS | 7758 | __end_tp_report 23:21:11 INFO - PROCESS | 7758 | __start_cc_report 23:21:11 INFO - PROCESS | 7758 | _x_x_mozilla_cycle_collect,1960 23:21:11 INFO - PROCESS | 7758 | __end_cc_report 23:21:11 INFO - PROCESS | 7758 | __startTimestamp1472106071378__endTimestamp 23:21:11 INFO - PROCESS | 7758 | 23:21:11 INFO - PROCESS | 7758 | ------- Summary: start ------- 23:21:11 INFO - PROCESS | 7758 | Number of tests: 14 23:21:11 INFO - PROCESS | 7758 | 23:21:11 INFO - PROCESS | 7758 | [#0] ai-astar Cycles:10 Average:116.50 Median:115.50 stddev:4.65 (4.0%) stddev-sans-first:4.93 23:21:11 INFO - PROCESS | 7758 | Values: 117.0 115.0 129.0 118.0 114.0 114.0 114.0 113.0 115.0 116.0 23:21:11 INFO - PROCESS | 7758 | 23:21:11 INFO - PROCESS | 7758 | [#1] audio-beat-detection Cycles:10 Average:148.10 Median:148.00 stddev:27.17 (18.4%) stddev-sans-first:28.28 23:21:11 INFO - PROCESS | 7758 | Values: 163.0 121.0 151.0 202.0 128.0 145.0 144.0 123.0 181.0 123.0 23:21:11 INFO - PROCESS | 7758 | 23:21:11 INFO - PROCESS | 7758 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.14 (0.7%) stddev-sans-first:1.20 23:21:11 INFO - PROCESS | 7758 | Values: 161.0 160.0 161.0 159.0 162.0 161.0 162.0 162.0 159.0 161.0 23:21:11 INFO - PROCESS | 7758 | 23:21:11 INFO - PROCESS | 7758 | [#3] audio-fft Cycles:10 Average:93.90 Median:75.50 stddev:38.30 (50.7%) stddev-sans-first:40.00 23:21:11 INFO - PROCESS | 7758 | Values: 75.0 75.0 74.0 169.0 77.0 76.0 77.0 77.0 164.0 75.0 23:21:11 INFO - PROCESS | 7758 | 23:21:11 INFO - PROCESS | 7758 | [#4] audio-oscillator Cycles:10 Average:105.20 Median:86.00 stddev:30.37 (35.3%) stddev-sans-first:31.41 23:21:11 INFO - PROCESS | 7758 | Values: 86.0 86.0 147.0 86.0 86.0 86.0 156.0 88.0 87.0 144.0 23:21:11 INFO - PROCESS | 7758 | 23:21:11 INFO - PROCESS | 7758 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 23:21:11 INFO - PROCESS | 7758 | Values: 117.0 117.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 23:21:11 INFO - PROCESS | 7758 | 23:21:11 INFO - PROCESS | 7758 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 23:21:11 INFO - PROCESS | 7758 | Values: 147.0 147.0 147.0 148.0 147.0 147.0 147.0 146.0 147.0 147.0 23:21:11 INFO - PROCESS | 7758 | 23:21:11 INFO - PROCESS | 7758 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 23:21:11 INFO - PROCESS | 7758 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 23:21:11 INFO - PROCESS | 7758 | 23:21:11 INFO - PROCESS | 7758 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:66.50 stddev:1.07 (1.6%) stddev-sans-first:1.13 23:21:11 INFO - PROCESS | 7758 | Values: 66.0 67.0 65.0 67.0 66.0 68.0 66.0 68.0 65.0 66.0 23:21:11 INFO - PROCESS | 7758 | 23:21:11 INFO - PROCESS | 7758 | [#9] json-stringify-tinderbox Cycles:10 Average:65.60 Median:66.00 stddev:0.84 (1.3%) stddev-sans-first:0.67 23:21:11 INFO - PROCESS | 7758 | Values: 64.0 65.0 65.0 66.0 66.0 65.0 67.0 66.0 66.0 66.0 23:21:11 INFO - PROCESS | 7758 | 23:21:11 INFO - PROCESS | 7758 | [#10] stanford-crypto-aes Cycles:10 Average:84.40 Median:83.50 stddev:3.03 (3.6%) stddev-sans-first:3.08 23:21:11 INFO - PROCESS | 7758 | Values: 82.0 83.0 83.0 82.0 86.0 84.0 83.0 83.0 92.0 86.0 23:21:11 INFO - PROCESS | 7758 | 23:21:11 INFO - PROCESS | 7758 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:133.50 stddev:6.52 (4.9%) stddev-sans-first:6.59 23:21:11 INFO - PROCESS | 7758 | Values: 141.0 144.0 132.0 134.0 131.0 131.0 129.0 131.0 148.0 133.0 23:21:11 INFO - PROCESS | 7758 | 23:21:11 INFO - PROCESS | 7758 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.80 Median:174.50 stddev:2.39 (1.4%) stddev-sans-first:2.32 23:21:11 INFO - PROCESS | 7758 | Values: 171.0 173.0 173.0 177.0 171.0 177.0 174.0 176.0 175.0 171.0 23:21:11 INFO - PROCESS | 7758 | 23:21:11 INFO - PROCESS | 7758 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:2.00 (2.9%) stddev-sans-first:2.11 23:21:11 INFO - PROCESS | 7758 | Values: 70.0 68.0 74.0 69.0 68.0 69.0 67.0 68.0 71.0 69.0 23:21:11 INFO - PROCESS | 7758 | -------- Summary: end -------- 23:21:11 INFO - PROCESS | 7758 | 23:21:12 INFO - TEST-INFO | 7758: exit 0 23:21:12 INFO - TEST-OK | kraken | took 64161ms 23:21:12 INFO - SUITE-END | took 1185s 23:21:13 INFO - Completed test suite (00:19:45) 23:21:13 INFO - javascript benchmark 23:21:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2580.329114430248, 2588.9870550647242, 2597.5454295498284, 2611.399378143027, 2620.5283049051163, 4601.7238965662, 4640.907181856365, 4671.322658214557, 4711.269753188257, 4755.381800365952, 4662.230731929228, 4691.624670026398, 4738.549837765416, 4744.28835674649, 4785.306130611059, 4299.0, 4329.718568293051, 4365.192439398706, 4431.512533621299, 4476.992676647761, 4381.75900325482, 4408.537103604108, 4423.491298500665, 4447.866564003085, 4449.510553839075, 4250.08623146022, 4273.358996150571, 4281.48622165339, 4284.65722742183, 4327.6105150536605, 4279.144171165748, 4289.528151903288, 4302.569743025703, 4314.18030574193, 4329.935050974238, 4238.046439551107, 4259.5101563319995, 4308.806103725308, 4311.417958575584, 4318.956810431887, 4657.930131048003, 4719.386479757643, 4735.408073990751, 4744.335792988984, 4762.261849413347, 4855.295982082614, 4889.437714662824, 4914.164592019365, 4987.875303117415, 5052.115879721034, 5078.949210507884, 5091.770870310808, 5093.745312734385, 5097.592192624581, 5104.540591346797, 4764.213904705754, 4767.73777442237, 4772.737499437564, 4812.470628230857, 4824.34871292378, 5018.447970723218, 5066.974665126724, 5152.6650767699975, 5154.149565321755, 5182.740862956837, 4923.803047878117, 4954.628402869799, 4958.876028099255, 4961.131801934647, 5003.149464591028, 5032.220005899091, 5035.647504674711, 5037.29477873098, 5060.987802439527, 5086.186210206423, 4848.975755121272, 4889.193283108319, 4916.827911023097, 4959.528844759742, 4992.450830408652, 4957.801687932442, 4963.776630051656, 4965.851024469272, 5007.349044624176, 5025.899482010339, 4269.91460170801, 4272.739541835104, 4273.55127711592, 4320.546342634041, 4327.415798867176, 3711.406175011985, 3718.3307004738867, 3723.2925744108534, 3729.6083911189476, 3799.4870692456716, 4275.0381164238415, 4293.463317085364, 4301.139772045603, 4344.47866256045, 4348.804303806336, 5038.874028149326, 5045.772940217699, 5050.242463630485, 5052.115879721107, 5100.030994111107, 4181.581841815794, 4259.254630439661, 4300.1399720056115, 4303.548127446636, 4309.07354918694, 4518.457785065813, 4544.045750392388, 4559.4072770539615, 4603.102395032936, 4620.768961551909, 4768.976155119133, 4770.952290477189, 4772.785224664829, 4774.7851346688785, 4834.444038935568, 4920.45874953762, 5000.599952003904, 5064.063148317573, 5066.392032956069, 5068.467810879804, 4739.336492890929, 4759.881002974953, 4763.237881938873, 4827.155247831685, 4829.830955916526, 4969.055879382906, 4980.003999200102, 4985.252212168204, 4986.252062190555, 5049.394072711299, 4919.655624106278, 4956.3804524434445, 5032.27032080339, 5055.3933527975405, 5102.897942041064, 4871.439784424837, 4884.975575122102, 4890.462049174659, 4920.630952678492, 4948.653594248368, 4874.390701162355, 4877.414840176886, 4882.707037577757, 4889.511048895082, 4950.8267210647455, 4730.101280756645, 4812.25410061441, 4814.614830813596, 4823.155947709207, 4875.853724388274, 4919.2129259318335, 4953.702777833341, 4974.726390048582, 5028.321176641253, 5037.874053148701, 4856.902861942812, 4864.610831133572, 4866.343043689057, 4870.561649451566, 4933.9013219736125], "value": 4621.662121997325, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [559.253396715385, 568.8663164156422, 573.8077743955773, 580.0776764943738, 587.7325816753372, 27757.306067348327, 38631.0, 39872.40191397131, 39931.80034099833, 43394.0, 39284.80357598208, 39868.60131398685, 39909.800450997776, 39958.40062399067, 39959.0, 7552.773416797491, 7689.615519224017, 7693.076830780315, 7694.576798276093, 7695.115061767912, 7384.704611815521, 9562.235021198323, 9810.068043535854, 9817.214622830157, 10139.594416223343, 10012.449315287657, 10098.040686134842, 10107.797844043114, 10114.74713132174, 10115.39307641544, 9842.90157098427, 9897.653582124663, 9913.454759988197, 9923.900760992407, 9924.15644670204, 9801.313908026441, 9856.802863942681, 9866.65466708669, 9872.35829671069, 9873.0, 35624.28751424983, 35842.82078589591, 36033.279334413164, 36037.63962360369, 36063.4590481143, 2876.367199216169, 2956.674765775763, 3002.369502404498, 3080.768942329312, 3118.70372314632, 27852.0, 28724.569131463046, 29101.563476547868, 29254.70745292541, 29829.25426864324, 3433.1073920780527, 3477.930441391183, 3479.321532301177, 3512.332656795201, 3553.502509648651, 244225.0, 246801.0, 247201.0, 248724.0, 249334.0, 49991.75004124956, 50408.24387634188, 50441.0, 50463.0, 50473.24290135651, 32026.67973320237, 32654.183645409055, 32802.8359858204, 34687.22502199818, 34714.13214669603, 13518.662033449242, 13625.04624676283, 13641.590752277447, 13702.45190192401, 13710.17738935667, 9288.860667089999, 9536.189423898908, 9850.80298394028, 9874.802503950024, 9942.850857237147, 15653.0, 15752.684946301239, 17200.913995429943, 17722.20250088749, 17796.55508612295, 6730.192376914802, 6869.725210991504, 6871.725130994704, 6889.968413897869, 7010.831116292433, 781.8514482248355, 863.4171933944563, 870.3385427075342, 933.9486328251876, 952.4142652268805, 26986.865065674545, 27401.725982740318, 27464.0, 27661.585076223873, 28262.293442663686, 882.9867551986725, 919.3932004876883, 1015.5277795824977, 1017.3234798858824, 1030.7938412317417, 14643.853561464462, 14741.0, 14962.40150393972, 15030.475943457503, 15033.697768458846, 370437.0, 378755.0, 378812.0, 380582.0, 381063.0, 47316.5268347319, 47903.28145077827, 47909.52090479121, 47935.520644793105, 47979.760101199274, 1158.6060739348661, 1172.554429316854, 1176.505867535637, 1178.6051672689746, 1179.6637958181877, 25914.740852591232, 27087.59368609512, 27434.45131097327, 27934.580981285704, 28021.57967630528, 41221.38167927424, 41382.0, 41461.1707765837, 41484.58515414928, 41543.58456415518, 262656.0, 263342.0, 263343.0, 263525.0, 263790.0, 21861.890690546446, 23743.0, 24519.38701532476, 24950.875245623654, 25324.366890827878, 40886.79556602198, 41146.58853411428, 41185.38221926614, 41945.79027104845, 42327.15345693007, 34414.48378274278, 34702.82648586741, 34759.304813904084, 34874.30251394907, 35165.824170880005, 34248.31503369869, 34407.0, 34624.82687586546, 34794.0, 35172.648273516934, 35034.82482587571, 35339.82330088436, 35456.29087418289, 35598.82200589084, 36457.453138202414, 30942.22644433907, 32890.34219315648, 33115.50326745149, 33123.83438082794, 33853.3229335407, 24855.378615534755, 25231.621525677496, 25279.0, 25418.745812542376, 25698.61452078183], "value": 17251.1847721548, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [363.6636111596771, 369.4089456869009, 371.09452934839, 373.3876442634082, 390.4982098004065, 15688.921555392222, 16843.49469515915, 17005.744913826304, 17014.914925425357, 17093.82906170938, 15822.367105315774, 16704.580110690607, 16786.0, 16788.83211167888, 16928.74606880895, 4790.496997815231, 5076.162433198518, 5079.644424890259, 5096.694198348093, 5098.770555325001, 3776.9433458498142, 3918.804059797013, 3944.9408258876138, 3949.526056873179, 5092.84721458355, 5964.045752679572, 6034.185384973016, 6047.5766696331275, 6049.153118563405, 6055.303640081403, 5083.542481176712, 5337.4662533746705, 6044.486218671396, 6071.666058366788, 6072.362401947798, 5250.18622113573, 5257.106291930381, 5260.342457192851, 5261.973690131563, 5262.263283140325, 10575.35616095976, 11623.779503152131, 20803.37589872306, 20904.059317330757, 21017.5796484071, 1779.234928980538, 1779.830916062972, 1780.6616742818953, 1791.5968906995952, 1829.3322937127984, 8423.536705481258, 8632.13678632138, 9086.409383390124, 9144.634214631407, 9267.76830579241, 1655.7516372544094, 1704.292718521812, 1713.0620985010687, 1713.9057351845643, 1778.1376032624166, 62253.68873155605, 66171.66914165446, 67939.3206067938, 68579.31420685779, 69699.30300696979, 9662.0, 9797.265205109645, 9942.403455792675, 10246.282760206714, 10614.734631634117, 13249.403776830066, 13337.866621333857, 13370.197788132744, 13375.53185638498, 13380.264085475197, 6877.6217308048535, 7081.504294699322, 7181.06646135999, 7219.819504512324, 7260.782176534713, 6791.2190098139345, 6862.897056544156, 6967.82580435483, 7141.857162856818, 7159.248278930637, 3925.7840818755244, 3928.1750832325533, 3981.8606348778235, 4062.878113656595, 4085.20338533983, 1809.6290260496567, 1821.4535639308156, 1836.6418548383203, 1867.3650958674116, 1895.109298629642, 754.4492520460095, 817.7342363731692, 852.1776485691338, 896.6996056321075, 901.9864702029474, 16434.67130657404, 16655.41706040283, 17078.0, 17426.302947882195, 17611.55971100707, 798.8841617965362, 808.1554775259867, 809.5426084262491, 813.9959300203461, 827.4952279109739, 9230.907690923004, 9265.583048762823, 9730.659426920023, 9777.168940639984, 9800.754981125529, 276138.0, 279281.0, 279675.0, 374754.0, 381740.0, 47381.52618473771, 47993.76081109433, 81997.59001205076, 82991.58504207562, 83178.58410707908, 922.524899676667, 946.2240962410895, 948.7011591348703, 955.0, 967.6516454076527, 15661.361909712723, 15776.053436793829, 15819.762703559685, 16179.352825886832, 16582.75125873089, 36758.816205919866, 36938.261234775695, 37317.4402383959, 38006.65840586435, 39915.0, 50394.7480262611, 50606.49393506165, 50758.746206268734, 52239.73880130575, 53036.0, 6905.827354316182, 7054.118235220598, 7170.784876453715, 7364.153122390993, 7575.393968482398, 10995.945020274847, 11105.888941110808, 11116.333020018825, 11155.944220278847, 11336.773264534828, 9072.546372681472, 9902.356346837432, 9915.752106197402, 10279.074883260542, 10454.372737635766, 10301.0, 10359.32664376813, 10432.165426765689, 10587.735306617396, 11102.722431939266, 10056.19550435978, 10303.948480257552, 10463.790724185626, 10515.894841051491, 10801.189910756882, 7152.463565232524, 7209.855802884018, 7265.62810475706, 7523.811904702427, 7527.247275272429, 9036.186743193144, 9871.160951319218, 9981.45102019396, 10251.538680759533, 10287.897121028695], "value": 7964.714611852252, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1257.490716259915, 1353.844307904591, 1382.7925811128332, 1436.360819435351, 1644.7089035107435, 6637.701303441345, 7347.88978165328, 7621.0, 7627.427942904291, 7800.219978002211, 7635.121960974489, 7680.039995000625, 7691.6154192290305, 7692.9230707692905, 7694.153643099255, 2116.2698868890284, 2131.8081372676456, 2134.5165110248386, 2135.2313167259854, 2147.1518750093705, 2078.2206672497814, 2123.5859007493546, 2141.486043349593, 2144.5603651251454, 2151.0857885398723, 2078.968815467769, 2089.300084471704, 2101.2645574049116, 2102.926397576085, 2139.229877244191, 2055.0033233881554, 2057.40335302762, 2060.2994981706292, 2063.9071241794154, 2065.3597384810755, 2065.3597384810605, 2126.1070350452846, 2126.670366093258, 2129.99890051677, 2132.424245453719, 7606.6196690165825, 7645.808854778619, 7675.232476752336, 7783.961080194619, 7787.727429539939, 4354.521002689701, 4521.253993091136, 4532.3201519771965, 4536.977315113436, 4540.614047805941, 2807.9719202807914, 2934.369110641201, 2981.7465515431213, 2996.580478732979, 3002.879884804627, 923.1922068190333, 927.7958849053198, 929.4794914847707, 932.6176267730266, 953.3707752883064, 10004.349717268355, 10058.245631577662, 10082.596696132146, 10105.938876417944, 10122.797544049152, 3947.1513624570857, 4014.8594799181888, 4098.5286692030795, 4099.692523060782, 4226.704130710821, 8152.510849349058, 8330.375221858385, 8333.083360830304, 8344.707935222359, 8349.95825020871, 4453.198424283595, 4458.06380660065, 4459.3979812724865, 4460.420145381079, 4462.352958820953, 3563.768355056913, 3952.8418863245147, 4078.3678529827926, 4100.876973690794, 4114.547399786021, 3165.8100513969234, 3191.9042428727175, 3303.735701143951, 3312.0726196664973, 3328.5340052392685, 938.3244064273712, 938.6245501799199, 945.1163162443138, 946.8437707778277, 954.0268925695751, 822.153182222312, 830.8836762853206, 845.8758587824232, 851.476342049635, 853.6756032707532, 5036.118679231193, 5132.626060784272, 5139.434662187156, 5182.486494050382, 5269.0, 383.4746397435531, 389.34395543509277, 398.6013986013986, 404.62167873038806, 404.63784912503144, 3547.035584937059, 3657.140571965586, 3704.0, 3712.3874560697723, 3801.82891769871, 9148.725538233864, 9589.472579008081, 9591.0, 9604.135627793532, 9686.515674216262, 9390.718278451657, 9439.716808495756, 9509.524523773784, 9513.714588562354, 9551.331406801457, 7002.894956575554, 7118.679659415338, 7151.499395042297, 7180.820479488055, 7214.891776623354, 4920.36035315421, 4957.876053098701, 5045.066662667418, 5092.439831618593, 5289.2330612061805, 8248.10293632456, 8488.278496327881, 8522.829543408972, 8573.18554737299, 8632.136786321318, 8538.487690738575, 8918.598663060047, 8953.343631427946, 9017.0, 9048.773780655536, 6072.392760724069, 6538.215414150332, 6747.2915343890145, 6844.0, 6889.793306200822, 7251.673674684757, 7551.773446796605, 7570.129435114812, 7571.507851989823, 7574.394048475999, 6499.0, 6518.250401203923, 6664.966675166787, 6703.832404189934, 6786.898196526958, 6507.6746162692625, 6508.934910651023, 6568.080468734476, 6604.735810567716, 6609.272979972103, 6339.429451349401, 6409.455196308366, 6426.710798014195, 6452.838679033061, 6467.12453388512, 4631.351610774562, 4639.2113340731485, 4716.481187069488, 4759.214729569582, 4819.3252944588485, 4577.679562430598, 4652.55800698933, 4658.976705116588, 4677.345171676036, 4919.975400122977], "value": 3943.9038755974316, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [285.79565610588423, 292.76139945944055, 297.4215151530274, 298.08933707523505, 304.7242245767581, 4693.249080147177, 4846.110017093332, 4864.173090574602, 4888.902221955564, 4902.289168070628, 4647.721136731799, 4781.856544303677, 4810.350602668639, 4819.421669399668, 4819.975900120495, 3817.236552689459, 3822.2355528894195, 3833.4249862520564, 3837.1558257183374, 3837.9232415351676, 3601.2617413430185, 3655.0, 3846.1346197105568, 3879.70902182336, 3886.261610294049, 3792.355299599075, 3807.9428808567895, 3809.9141744602794, 3812.82842272097, 3816.4466152407886, 3792.981035094807, 3797.259534390795, 3809.8285577148954, 3826.9808650956847, 3827.4832897558754, 3367.0235631667033, 3371.679690429405, 3376.57792775903, 3394.7114495267933, 3397.4903764435285, 4546.840860569864, 4686.7656617169005, 4708.340832283483, 4719.952800471986, 4762.737699592701, 4333.06839029607, 4342.457192850894, 4348.760818155, 4351.998080882798, 4370.077166046929, 5019.247112933052, 5053.8231161909525, 5069.493050694938, 5095.757866538711, 5112.718800465973, 3595.01137187273, 3689.1330537323706, 3691.483192353073, 3715.516982792247, 3724.7020238380865, 5214.739263036833, 5245.580353571705, 5248.396434410053, 5249.4488078751565, 5262.342362155909, 3759.6240375962184, 3762.2663580602066, 3763.8357944182203, 3774.75464094833, 3782.3380908340932, 3844.788536630512, 3850.441685955521, 3851.441540976543, 3855.51806024247, 3857.787821669779, 4134.896627584274, 4284.700070995001, 4289.970407102273, 4325.091730736518, 4334.591257841214, 5018.974905125451, 5022.196448568285, 5026.547610715053, 5042.899142017139, 5050.545450909436, 1252.2173641474078, 1280.1934781088041, 1310.28589418767, 1312.2651315263483, 1331.161368337941, 881.5151666583354, 898.6225785170244, 914.1772404835568, 916.5829547555846, 916.8670542771395, 4352.932357130338, 4362.825486980549, 4387.36383224437, 4413.249747542925, 4417.182821178092, 5125.461826508237, 5132.974335128375, 5137.768800403991, 5144.176931690911, 5153.2785410042625, 4377.9124417511475, 4384.539623339567, 4404.2512772828695, 4415.933760993587, 4416.690831641754, 2317.8145748340094, 2423.515296940619, 2425.6604075429454, 2432.795766095794, 2435.4276744965273, 4312.223799716081, 4337.566243375637, 4339.414179085783, 4346.956530434719, 4350.543192964757, 4646.5353464653945, 4657.69724967876, 4675.485696573374, 4675.807669044372, 4698.2952557116705, 4150.584941505826, 4295.634871035934, 4328.502222244482, 4329.978350108229, 4350.825966961286, 4543.477934891848, 4555.724397168798, 4557.5442455754155, 4575.512958288636, 4585.372192871482, 4485.955140448554, 4497.707649002804, 4507.940633951084, 4519.751413672279, 4543.522930092425, 4009.9975006248437, 4294.549072347359, 4342.523541995736, 4344.283193273074, 4360.847370342023, 3410.9829450852585, 3421.26442814796, 3424.2637832866053, 3426.7429942753893, 3439.570053743282, 4521.683482156218, 4540.273556230987, 4571.519990401093, 4591.117641766859, 4889.242167464049, 4818.855434336975, 5031.295618613324, 5033.723145227048, 5038.2190760432195, 5039.622028347815, 5001.199568155534, 5004.474530174425, 5014.648974571745, 5033.0, 5047.425812835407, 4849.684770489906, 4958.652894297365, 4963.900721985612, 4970.950290497193, 4989.875253118701, 5035.093683137071, 5045.772940217773, 5058.747062646927, 5089.51649593288, 5090.541851233407, 4920.975395123001, 4953.331300274417, 4961.950380496293, 4967.329410529533, 4973.030259099441], "value": 3711.756512813556, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [603.261005268546, 613.7544982007197, 659.6833519910446, 695.7808290388531, 717.0749732844631, 12874.227546347214, 13201.867981320196, 14082.929585352073, 14652.26738663068, 14678.486252981147, 13646.0, 14017.229052402114, 14090.436382544685, 14097.365618547165, 14190.574282771533, 625.8466675664446, 753.2768542199495, 771.9768406947773, 774.570113586959, 775.8099265679916, 747.0960138232745, 768.9461737678365, 770.4606775257314, 785.7053604898164, 786.8504984053012, 810.9837803243931, 814.5886327404652, 816.0900595835631, 816.9387295952797, 817.0971076959963, 650.3626446082818, 815.0179034263728, 816.4774544291658, 817.1868990354576, 817.207308910359, 574.5087949802942, 588.7115313496356, 590.0853676800941, 592.8873514032321, 593.1192179613271, 12965.481380744759, 13039.478420863154, 13050.086493945428, 13063.542776002794, 13208.405621746948, 12468.189567678071, 13216.207027578375, 13384.86615133846, 13490.730185396236, 13537.323133843367, 11653.242539235007, 11755.588554400554, 11896.940515297454, 11940.283582985048, 12656.493740250471, 4196.559361267054, 4258.041940563379, 4265.786710664485, 4276.358546218092, 4306.354046892991, 64429.0, 65338.0, 65352.0, 65416.0, 66009.66995165042, 10780.29928054674, 11137.05335046514, 11174.27367221128, 11219.1585631078, 11223.55105795759, 20062.49843753918, 20109.899450502653, 20115.0, 20149.39551813448, 20195.394138175878, 6287.2140982377205, 6512.218533775977, 6651.135352404156, 6760.7295708172105, 6835.14560679915, 3719.9070023249637, 3740.551133863954, 3743.4010558311084, 3777.6788972937056, 3861.5945325740954, 2899.275181204699, 3030.8939187128344, 3034.543419158816, 3038.2404398900276, 3041.8935337263533, 508.74054232341774, 510.49716029710703, 511.4348644747575, 511.4476365525224, 522.8326935380642, 426.6650679216862, 469.59380136181954, 520.8125074973007, 528.6510902804208, 540.0656863625949, 7593.139680778245, 7745.728899488491, 7835.373170146375, 7933.484323518953, 7942.0, 532.5287120898033, 539.2558269588022, 539.9298091248113, 567.7700531284754, 582.6009183709173, 3504.3867323218333, 3775.2826962876966, 3791.4881490998914, 3872.6127387261613, 3889.202713443737, 57708.71145644329, 67341.66329168323, 95820.0, 108238.0, 108563.45718271358, 53912.913063040854, 84445.0, 85188.14811851802, 85671.5716421414, 85715.0, 47349.28976065362, 48876.511234887905, 75705.62147189229, 78256.0, 78883.0, 7136.393406560501, 7154.642267886481, 7275.854482910418, 7280.96359518199, 7457.067866516685, 48433.515664842904, 48468.0, 49111.0, 49479.50520494749, 50826.745866271915, 65431.0, 71178.28821711717, 71514.64242678753, 72168.0, 73497.0, 10304.072633463024, 10690.62582809598, 10941.781164376509, 11123.944380278046, 11670.299782013106, 12461.626151215478, 12497.18768280059, 12908.290044047291, 12956.28740419286, 13600.86399135996, 11623.418829058344, 12095.395230238277, 12349.135560511037, 12517.624471265877, 12658.303793291458, 11137.164712646421, 11488.080953523866, 11490.138239631893, 11607.187496875475, 12194.329311887932, 10800.837987430352, 11286.830697539708, 11318.26431281964, 11408.600698975828, 11582.826257605973, 9484.099010594258, 9575.664851730435, 9619.615215391586, 9627.711168664951, 9711.0, 9830.459324737209, 10121.190304775748, 10196.133328667147, 10215.0, 10271.640492582725], "value": 6576.762747082744, "unit": "score"}], "name": "dromaeo_css", "value": 6276.624708413687, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 115.0, 129.0, 118.0, 114.0, 114.0, 114.0, 113.0, 115.0, 116.0], "value": 116.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 121.0, 151.0, 202.0, 128.0, 145.0, 144.0, 123.0, 181.0, 123.0], "value": 148.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 161.0, 159.0, 162.0, 161.0, 162.0, 162.0, 159.0, 161.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 74.0, 169.0, 77.0, 76.0, 77.0, 77.0, 164.0, 75.0], "value": 93.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 147.0, 86.0, 86.0, 86.0, 156.0, 88.0, 87.0, 144.0], "value": 105.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 147.0, 147.0, 147.0, 146.0, 147.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 67.0, 66.0, 68.0, 66.0, 68.0, 65.0, 66.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 66.0, 66.0, 65.0, 67.0, 66.0, 66.0, 66.0], "value": 65.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 83.0, 82.0, 86.0, 84.0, 83.0, 83.0, 92.0, 86.0], "value": 84.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 144.0, 132.0, 134.0, 131.0, 131.0, 129.0, 131.0, 148.0, 133.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 173.0, 173.0, 177.0, 171.0, 177.0, 174.0, 176.0, 175.0, 171.0], "value": 173.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 68.0, 74.0, 69.0, 68.0, 69.0, 67.0, 68.0, 71.0, 69.0], "value": 69.3, "unit": "score"}], "name": "kraken", "value": 1578.1000000000001, "alertThreshold": 2.0}]} 23:21:13 INFO - Return code: 0 23:21:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:21:13 INFO - # TBPL SUCCESS # 23:21:13 INFO - Running post-action listener: _resource_record_post_action 23:21:13 INFO - [mozharness: 2016-08-25 06:21:13.164234Z] Finished run-tests step (success) 23:21:13 INFO - Running post-run listener: _resource_record_post_run 23:21:13 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 3547136; Write bytes: 407588864; Read time: 576; Write time: 323528 23:21:13 INFO - TinderboxPrint: CPU usage
13.1% 23:21:13 INFO - TinderboxPrint: I/O read bytes / time
3,547,136 / 576 23:21:13 INFO - TinderboxPrint: I/O write bytes / time
407,588,864 / 323,528 23:21:13 INFO - TinderboxPrint: CPU idle
8,334.5 (86.9%) 23:21:13 INFO - TinderboxPrint: CPU user
1,205.9 (12.6%) 23:21:13 INFO - TinderboxPrint: Swap in / out
0 / 0 23:21:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113516544; Read time: 0; Write time: 80348 23:21:13 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 3543040; Write bytes: 294072320; Read time: 576; Write time: 243180 23:21:13 INFO - Running post-run listener: _upload_blobber_files 23:21:13 INFO - Blob upload gear active. 23:21:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:21:13 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 23:21:13 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'] 23:21:13 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 23:21:14 INFO - (blobuploader) - INFO - Open directory for files ... 23:21:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:21:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:21:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:21:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:21:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:21:14 INFO - (blobuploader) - INFO - Done attempting. 23:21:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:21:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:21:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:21:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:21:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:21:19 INFO - (blobuploader) - INFO - Done attempting. 23:21:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:21:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:21:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:21:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:21:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:21:19 INFO - (blobuploader) - INFO - Done attempting. 23:21:19 INFO - (blobuploader) - INFO - Iteration through files over. 23:21:19 INFO - Return code: 0 23:21:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:21:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:21:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c6270c086edd65b16e530a955a5def930ab44498a5d0e247323971b3b070fde50e670ef02350e9e71654157120adf2af8e465573cdfc1e906240f4318b753b89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5e816aad86d9c87b6caf48b152bfa7ebff132d758be802e50eb4cd4510615dec1c4795d419bfe4b6872c4565a0946a3155846ac86c6a55b3e1343d22db4e4093", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/376abd10d6810b7bf058cad63a81eb46288bd59a0dfae673ed1a558f0bc814a8adbf54bb048df226086769968bdbaeb0900c459d3b767dd98326b8f3931f7997"} 23:21:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:21:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:21:19 INFO - Contents: 23:21:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c6270c086edd65b16e530a955a5def930ab44498a5d0e247323971b3b070fde50e670ef02350e9e71654157120adf2af8e465573cdfc1e906240f4318b753b89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5e816aad86d9c87b6caf48b152bfa7ebff132d758be802e50eb4cd4510615dec1c4795d419bfe4b6872c4565a0946a3155846ac86c6a55b3e1343d22db4e4093", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/376abd10d6810b7bf058cad63a81eb46288bd59a0dfae673ed1a558f0bc814a8adbf54bb048df226086769968bdbaeb0900c459d3b767dd98326b8f3931f7997"} 23:21:19 INFO - Running post-run listener: copy_logs_to_upload_dir 23:21:19 INFO - Copying logs to upload dir... 23:21:19 INFO - mkdir: /builds/slave/test/build/upload/logs 23:21:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.655702 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-24 23:21:19.849699) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 23:21:19.853187) ========= 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=a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673 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/c6270c086edd65b16e530a955a5def930ab44498a5d0e247323971b3b070fde50e670ef02350e9e71654157120adf2af8e465573cdfc1e906240f4318b753b89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5e816aad86d9c87b6caf48b152bfa7ebff132d758be802e50eb4cd4510615dec1c4795d419bfe4b6872c4565a0946a3155846ac86c6a55b3e1343d22db4e4093", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/376abd10d6810b7bf058cad63a81eb46288bd59a0dfae673ed1a558f0bc814a8adbf54bb048df226086769968bdbaeb0900c459d3b767dd98326b8f3931f7997"} build_url:https://queue.taskcluster.net/v1/task/X_fQtgN6R0GX7Rye9CdejA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://queue.taskcluster.net/v1/task/X_fQtgN6R0GX7Rye9CdejA/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/c6270c086edd65b16e530a955a5def930ab44498a5d0e247323971b3b070fde50e670ef02350e9e71654157120adf2af8e465573cdfc1e906240f4318b753b89", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/5e816aad86d9c87b6caf48b152bfa7ebff132d758be802e50eb4cd4510615dec1c4795d419bfe4b6872c4565a0946a3155846ac86c6a55b3e1343d22db4e4093", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/376abd10d6810b7bf058cad63a81eb46288bd59a0dfae673ed1a558f0bc814a8adbf54bb048df226086769968bdbaeb0900c459d3b767dd98326b8f3931f7997"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-24 23:21:19.881302) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 23:21:19.881620) ========= 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=a0d2d2de893abaa8702a9954000001a7-1472104832.179462-1677912673 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004458 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-24 23:21:19.963599) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 23:21:19.963929) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-24 23:21:19.964239) ========= ========= Total master_lag: 0.18 =========