builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-043 starttime: 1471530736.35 results: success (0) buildid: 20160817220715 builduid: 258b63cb575f480a952c0455fd023a38 revision: d0efbd7c33fe76c4dfd70dbd204b158cc482ec52 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 07:32:16.354267) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-18 07:32:16.354678) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 07:32:16.354947) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-18 07:32:16.374195) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 07:32:16.374450) ========= 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=d2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-18 07:32:16-- 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% 94.2M=0s 2016-08-18 07:32:16 (94.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.227772 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 07:32:16.615580) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 07:32:16.615896) ========= 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=d2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019339 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 07:32:16.665061) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-18 07:32:16.665383) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev d0efbd7c33fe76c4dfd70dbd204b158cc482ec52 --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 d0efbd7c33fe76c4dfd70dbd204b158cc482ec52 --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=d2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-18 07:32:16,748 truncating revision to first 12 chars 2016-08-18 07:32:16,749 Setting DEBUG logging. 2016-08-18 07:32:16,749 attempt 1/10 2016-08-18 07:32:16,749 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/d0efbd7c33fe?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-18 07:32:17,415 unpacking tar archive at: autoland-d0efbd7c33fe/testing/mozharness/ program finished with exit code 0 elapsedTime=0.999933 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-18 07:32:17.678876) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 07:32:17.679184) ========= script_repo_revision: d0efbd7c33fe76c4dfd70dbd204b158cc482ec52 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-18 07:32:17.679557) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 07:32:17.679831) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-18 07:32:17.689733) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-18 07:32:17.690000) ========= /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=d2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:32:17 INFO - MultiFileLogger online at 20160818 07:32:17 in /builds/slave/test 07:32:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 07:32:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:32:17 INFO - {'append_to_log': False, 07:32:17 INFO - 'base_work_dir': '/builds/slave/test', 07:32:17 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 07:32:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:32:17 INFO - 'branch': 'Autoland-Non-PGO', 07:32:17 INFO - 'buildbot_json_path': 'buildprops.json', 07:32:17 INFO - 'config_files': ('talos/linux_config.py',), 07:32:17 INFO - 'default_actions': ('clobber', 07:32:17 INFO - 'read-buildbot-config', 07:32:17 INFO - 'download-and-extract', 07:32:17 INFO - 'populate-webroot', 07:32:17 INFO - 'create-virtualenv', 07:32:17 INFO - 'install', 07:32:17 INFO - 'run-tests'), 07:32:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:32:17 INFO - 'download_minidump_stackwalk': True, 07:32:17 INFO - 'download_symbols': 'ondemand', 07:32:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:32:17 INFO - 'tooltool.py': '/tools/tooltool.py', 07:32:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:32:17 INFO - '/tools/misc-python/virtualenv.py')}, 07:32:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:32:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:32:17 INFO - 'installer_path': 'installer.exe', 07:32:17 INFO - 'log_level': 'info', 07:32:17 INFO - 'log_name': 'talos', 07:32:17 INFO - 'log_to_console': True, 07:32:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:32:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:32:17 INFO - 'opt_config_files': (), 07:32:17 INFO - 'pip_index': False, 07:32:17 INFO - 'sps_profile': False, 07:32:17 INFO - 'sps_profile_interval': 0, 07:32:17 INFO - 'suite': 'dromaeojs', 07:32:17 INFO - 'system_bits': '32', 07:32:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:32:17 INFO - 'title': 'talos-linux64-ix-043', 07:32:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:32:17 INFO - 'use_talos_json': True, 07:32:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:32:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:32:17 INFO - 'work_dir': 'build'} 07:32:17 INFO - [mozharness: 2016-08-18 14:32:17.867627Z] Running clobber step. 07:32:17 INFO - Running pre-action listener: _resource_record_pre_action 07:32:17 INFO - Running main action method: clobber 07:32:17 INFO - rmtree: /builds/slave/test/build 07:32:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:32:18 INFO - Running post-action listener: _resource_record_post_action 07:32:18 INFO - [mozharness: 2016-08-18 14:32:18.840249Z] Finished clobber step (success) 07:32:18 INFO - [mozharness: 2016-08-18 14:32:18.840349Z] Running read-buildbot-config step. 07:32:18 INFO - Running pre-action listener: _resource_record_pre_action 07:32:18 INFO - Running main action method: read_buildbot_config 07:32:18 INFO - Using buildbot properties: 07:32:18 INFO - { 07:32:18 INFO - "project": "", 07:32:18 INFO - "product": "firefox", 07:32:18 INFO - "script_repo_revision": "production", 07:32:18 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 07:32:18 INFO - "repository": "", 07:32:18 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 07:32:18 INFO - "buildid": "20160817220715", 07:32:18 INFO - "pgo_build": "False", 07:32:18 INFO - "basedir": "/builds/slave/test", 07:32:18 INFO - "buildnumber": 321, 07:32:18 INFO - "slavename": "talos-linux64-ix-043", 07:32:18 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:32:18 INFO - "platform": "ubuntu64_hw", 07:32:18 INFO - "scheduler": "tests-autoland-linux64-talos", 07:32:18 INFO - "branch": "autoland", 07:32:18 INFO - "repo_path": "integration/autoland", 07:32:18 INFO - "revision": "d0efbd7c33fe76c4dfd70dbd204b158cc482ec52", 07:32:18 INFO - "stage_platform": "linux64", 07:32:18 INFO - "builduid": "258b63cb575f480a952c0455fd023a38", 07:32:18 INFO - "slavebuilddir": "test" 07:32:18 INFO - } 07:32:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/NoVgWCbsTP-c-cfWDxoJow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 07:32:18 INFO - Running post-action listener: _resource_record_post_action 07:32:18 INFO - [mozharness: 2016-08-18 14:32:18.842787Z] Finished read-buildbot-config step (success) 07:32:18 INFO - [mozharness: 2016-08-18 14:32:18.842877Z] Running download-and-extract step. 07:32:18 INFO - Running pre-action listener: _resource_record_pre_action 07:32:18 INFO - Running main action method: download_and_extract 07:32:18 INFO - mkdir: /builds/slave/test/build/tests 07:32:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:18 INFO - trying https://queue.taskcluster.net/v1/task/NoVgWCbsTP-c-cfWDxoJow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:32:18 INFO - Downloading https://queue.taskcluster.net/v1/task/NoVgWCbsTP-c-cfWDxoJow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:32:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NoVgWCbsTP-c-cfWDxoJow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:32:19 INFO - Downloaded 1361 bytes. 07:32:19 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 07:32:19 INFO - Using the following test package requirements: 07:32:19 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:32:19 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:32:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:32:19 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:32:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:32:19 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:32:19 INFO - u'jsshell-linux-x86_64.zip'], 07:32:19 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:32:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:32:19 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 07:32:19 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:32:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:32:19 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:32:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:32:19 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:32:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:32:19 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 07:32:19 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:32:19 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:32:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:19 INFO - trying https://queue.taskcluster.net/v1/task/NoVgWCbsTP-c-cfWDxoJow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:32:19 INFO - Downloading https://queue.taskcluster.net/v1/task/NoVgWCbsTP-c-cfWDxoJow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:32:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NoVgWCbsTP-c-cfWDxoJow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:32:20 INFO - Downloaded 20317507 bytes. 07:32:20 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 07:32:24 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:24 INFO - trying https://queue.taskcluster.net/v1/task/NoVgWCbsTP-c-cfWDxoJow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:32:24 INFO - Downloading https://queue.taskcluster.net/v1/task/NoVgWCbsTP-c-cfWDxoJow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 07:32:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NoVgWCbsTP-c-cfWDxoJow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:32:25 INFO - Downloaded 20317507 bytes. 07:32:25 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 07:32:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:30 INFO - trying https://queue.taskcluster.net/v1/task/NoVgWCbsTP-c-cfWDxoJow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:32:30 INFO - Downloading https://queue.taskcluster.net/v1/task/NoVgWCbsTP-c-cfWDxoJow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 07:32:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NoVgWCbsTP-c-cfWDxoJow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:32:31 INFO - Downloaded 14413981 bytes. 07:32:31 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 07:32:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:31 INFO - trying https://queue.taskcluster.net/v1/task/NoVgWCbsTP-c-cfWDxoJow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:32:31 INFO - Downloading https://queue.taskcluster.net/v1/task/NoVgWCbsTP-c-cfWDxoJow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:32:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NoVgWCbsTP-c-cfWDxoJow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:32:32 INFO - Downloaded 55768953 bytes. 07:32:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NoVgWCbsTP-c-cfWDxoJow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:32:32 INFO - mkdir: /builds/slave/test/properties 07:32:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:32:32 INFO - Writing to file /builds/slave/test/properties/build_url 07:32:32 INFO - Contents: 07:32:32 INFO - build_url:https://queue.taskcluster.net/v1/task/NoVgWCbsTP-c-cfWDxoJow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 07:32:33 INFO - Running post-action listener: _resource_record_post_action 07:32:33 INFO - Running post-action listener: set_extra_try_arguments 07:32:33 INFO - [mozharness: 2016-08-18 14:32:33.195787Z] Finished download-and-extract step (success) 07:32:33 INFO - [mozharness: 2016-08-18 14:32:33.196012Z] Running populate-webroot step. 07:32:33 INFO - Running pre-action listener: _resource_record_pre_action 07:32:33 INFO - Running main action method: populate_webroot 07:32:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:32:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:32:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:32:33 INFO - '--tppagecycles', 07:32:33 INFO - '7'], 07:32:33 INFO - 'tests': ['tsvgm']}}, 07:32:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:32:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:32:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:32:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:32:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:32:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:32:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:33 INFO - 'talos_options': ['--disable-e10s'], 07:32:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:32:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:32:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:33 INFO - 'talos_options': ['--disable-e10s'], 07:32:33 INFO - 'tests': ['damp', 'tps']}, 07:32:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:33 INFO - 'tests': ['damp', 'tps']}, 07:32:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:32:33 INFO - 'tests': ['dromaeo_dom']}, 07:32:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:32:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:32:33 INFO - 'tests': ['basic_compositor_video']}, 07:32:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:32:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:32:33 INFO - 'tests': ['a11yr', 07:32:33 INFO - 'ts_paint', 07:32:33 INFO - 'tpaint', 07:32:33 INFO - 'sessionrestore', 07:32:33 INFO - 'sessionrestore_no_auto_restore', 07:32:33 INFO - 'tabpaint']}, 07:32:33 INFO - 'other-e10s': {'tests': ['a11yr', 07:32:33 INFO - 'ts_paint', 07:32:33 INFO - 'tpaint', 07:32:33 INFO - 'sessionrestore', 07:32:33 INFO - 'sessionrestore_no_auto_restore', 07:32:33 INFO - 'tabpaint']}, 07:32:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:32:33 INFO - 'ts_paint', 07:32:33 INFO - 'tpaint', 07:32:33 INFO - 'sessionrestore', 07:32:33 INFO - 'sessionrestore_no_auto_restore', 07:32:33 INFO - 'tabpaint']}, 07:32:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:32:33 INFO - 'ts_paint', 07:32:33 INFO - 'tpaint', 07:32:33 INFO - 'sessionrestore', 07:32:33 INFO - 'sessionrestore_no_auto_restore', 07:32:33 INFO - 'tabpaint']}, 07:32:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:32:33 INFO - 'tests': ['a11yr', 07:32:33 INFO - 'ts_paint', 07:32:33 INFO - 'tpaint', 07:32:33 INFO - 'sessionrestore', 07:32:33 INFO - 'sessionrestore_no_auto_restore', 07:32:33 INFO - 'tabpaint']}, 07:32:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:32:33 INFO - 'tests': ['a11yr', 07:32:33 INFO - 'ts_paint', 07:32:33 INFO - 'tpaint', 07:32:33 INFO - 'sessionrestore', 07:32:33 INFO - 'sessionrestore_no_auto_restore', 07:32:33 INFO - 'tabpaint']}, 07:32:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:32:33 INFO - 'tests': ['tsvgx', 07:32:33 INFO - 'tsvgr_opacity', 07:32:33 INFO - 'tart', 07:32:33 INFO - 'tscrollx', 07:32:33 INFO - 'cart']}, 07:32:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:32:33 INFO - 'tsvgr_opacity', 07:32:33 INFO - 'tart', 07:32:33 INFO - 'tscrollx', 07:32:33 INFO - 'cart']}, 07:32:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:33 INFO - 'talos_options': ['--disable-e10s'], 07:32:33 INFO - 'tests': ['tp5o']}, 07:32:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:33 INFO - 'tests': ['tp5o']}, 07:32:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:33 INFO - 'talos_options': ['--disable-e10s', 07:32:33 INFO - '--xperf_path', 07:32:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:32:33 INFO - 'tests': ['tp5n']}, 07:32:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:32:33 INFO - 'talos_options': ['--xperf_path', 07:32:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:32:33 INFO - 'tests': ['tp5n']}}, 07:32:33 INFO - 'talos.zip': {'path': '', 07:32:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:32:33 INFO - Running post-action listener: _resource_record_post_action 07:32:33 INFO - [mozharness: 2016-08-18 14:32:33.212759Z] Finished populate-webroot step (success) 07:32:33 INFO - [mozharness: 2016-08-18 14:32:33.212847Z] Running create-virtualenv step. 07:32:33 INFO - Running pre-action listener: _resource_record_pre_action 07:32:33 INFO - Running main action method: create_virtualenv 07:32:33 INFO - Creating virtualenv /builds/slave/test/build/venv 07:32:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:32:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:32:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:32:33 INFO - Using real prefix '/usr' 07:32:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:32:33 INFO - Installing distribute.............................................................................................................................................................................................done. 07:32:35 INFO - Installing pip.................done. 07:32:35 INFO - Return code: 0 07:32:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:32: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')]} 07:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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')]} 07:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:35 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 0x7f3022bbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1944230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193e090>, '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 0x19419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1941e40>, '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': 'd2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:32:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:32:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:32:35 INFO - Using env: {'DISPLAY': ':0', 07:32:35 INFO - 'HOME': '/home/cltbld', 07:32:35 INFO - 'LANG': 'en_US.UTF-8', 07:32:35 INFO - 'LANGUAGE': 'en_US:en', 07:32:35 INFO - 'LOGNAME': 'cltbld', 07:32:35 INFO - 'MAIL': '/var/mail/cltbld', 07:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:35 INFO - 'MOZ_NO_REMOTE': '1', 07:32:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:35 INFO - 'NO_EM_RESTART': '1', 07:32:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:35 INFO - 'PWD': '/builds/slave/test', 07:32:35 INFO - 'SHELL': '/bin/bash', 07:32:35 INFO - 'SHLVL': '1', 07:32:35 INFO - 'TERM': 'linux', 07:32:35 INFO - 'TMOUT': '86400', 07:32:35 INFO - 'USER': 'cltbld', 07:32:35 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647', 07:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:35 INFO - '_': '/tools/buildbot/bin/python'} 07:32:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:35 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:32:35 INFO - Cleaning up... 07:32:35 INFO - Return code: 0 07:32:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:32: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')]} 07:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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')]} 07:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:35 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 0x7f3022bbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1944230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193e090>, '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 0x19419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1941e40>, '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': 'd2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:32:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:32:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:32:36 INFO - Using env: {'DISPLAY': ':0', 07:32:36 INFO - 'HOME': '/home/cltbld', 07:32:36 INFO - 'LANG': 'en_US.UTF-8', 07:32:36 INFO - 'LANGUAGE': 'en_US:en', 07:32:36 INFO - 'LOGNAME': 'cltbld', 07:32:36 INFO - 'MAIL': '/var/mail/cltbld', 07:32:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:36 INFO - 'MOZ_NO_REMOTE': '1', 07:32:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:36 INFO - 'NO_EM_RESTART': '1', 07:32:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:36 INFO - 'PWD': '/builds/slave/test', 07:32:36 INFO - 'SHELL': '/bin/bash', 07:32:36 INFO - 'SHLVL': '1', 07:32:36 INFO - 'TERM': 'linux', 07:32:36 INFO - 'TMOUT': '86400', 07:32:36 INFO - 'USER': 'cltbld', 07:32:36 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647', 07:32:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:36 INFO - '_': '/tools/buildbot/bin/python'} 07:32:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:36 INFO - Downloading/unpacking psutil>=3.1.1 07:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:32:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:32:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:32:38 INFO - Installing collected packages: psutil 07:32:38 INFO - Running setup.py install for psutil 07:32:38 INFO - building 'psutil._psutil_linux' extension 07:32:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:32:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:32:38 INFO - building 'psutil._psutil_posix' extension 07:32:38 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:32:38 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:32:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:32:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:32:38 INFO - Successfully installed psutil 07:32:38 INFO - Cleaning up... 07:32:38 INFO - Return code: 0 07:32:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:38 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 0x7f3022bbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1944230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193e090>, '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 0x19419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1941e40>, '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': 'd2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:32:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:32:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:32:38 INFO - Using env: {'DISPLAY': ':0', 07:32:38 INFO - 'HOME': '/home/cltbld', 07:32:38 INFO - 'LANG': 'en_US.UTF-8', 07:32:38 INFO - 'LANGUAGE': 'en_US:en', 07:32:38 INFO - 'LOGNAME': 'cltbld', 07:32:38 INFO - 'MAIL': '/var/mail/cltbld', 07:32:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:38 INFO - 'MOZ_NO_REMOTE': '1', 07:32:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:38 INFO - 'NO_EM_RESTART': '1', 07:32:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:38 INFO - 'PWD': '/builds/slave/test', 07:32:38 INFO - 'SHELL': '/bin/bash', 07:32:38 INFO - 'SHLVL': '1', 07:32:38 INFO - 'TERM': 'linux', 07:32:38 INFO - 'TMOUT': '86400', 07:32:38 INFO - 'USER': 'cltbld', 07:32:38 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647', 07:32:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:38 INFO - '_': '/tools/buildbot/bin/python'} 07:32:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:32:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:32:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:32:40 INFO - Installing collected packages: mozsystemmonitor 07:32:40 INFO - Running setup.py install for mozsystemmonitor 07:32:41 INFO - Successfully installed mozsystemmonitor 07:32:41 INFO - Cleaning up... 07:32:41 INFO - Return code: 0 07:32:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:41 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 0x7f3022bbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1944230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193e090>, '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 0x19419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1941e40>, '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': 'd2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:32:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:32:41 INFO - Using env: {'DISPLAY': ':0', 07:32:41 INFO - 'HOME': '/home/cltbld', 07:32:41 INFO - 'LANG': 'en_US.UTF-8', 07:32:41 INFO - 'LANGUAGE': 'en_US:en', 07:32:41 INFO - 'LOGNAME': 'cltbld', 07:32:41 INFO - 'MAIL': '/var/mail/cltbld', 07:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:41 INFO - 'MOZ_NO_REMOTE': '1', 07:32:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:41 INFO - 'NO_EM_RESTART': '1', 07:32:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:41 INFO - 'PWD': '/builds/slave/test', 07:32:41 INFO - 'SHELL': '/bin/bash', 07:32:41 INFO - 'SHLVL': '1', 07:32:41 INFO - 'TERM': 'linux', 07:32:41 INFO - 'TMOUT': '86400', 07:32:41 INFO - 'USER': 'cltbld', 07:32:41 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647', 07:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:41 INFO - '_': '/tools/buildbot/bin/python'} 07:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:41 INFO - Downloading/unpacking jsonschema==2.5.1 07:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:32:43 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:43 INFO - Downloading functools32-3.2.3-2.tar.gz 07:32:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:32:43 INFO - warning: no files found matching '*.txt' 07:32:43 INFO - no previously-included directories found matching 'build' 07:32:43 INFO - no previously-included directories found matching 'dist' 07:32:43 INFO - no previously-included directories found matching '.git*' 07:32:43 INFO - Installing collected packages: jsonschema, functools32 07:32:43 INFO - Running setup.py install for functools32 07:32:43 INFO - warning: no files found matching '*.txt' 07:32:43 INFO - no previously-included directories found matching 'build' 07:32:43 INFO - no previously-included directories found matching 'dist' 07:32:43 INFO - no previously-included directories found matching '.git*' 07:32:43 INFO - Successfully installed jsonschema functools32 07:32:43 INFO - Cleaning up... 07:32:43 INFO - Return code: 0 07:32:43 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3022bbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1944230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193e090>, '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 0x19419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1941e40>, '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': 'd2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:32:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:32:43 INFO - Using env: {'DISPLAY': ':0', 07:32:43 INFO - 'HOME': '/home/cltbld', 07:32:43 INFO - 'LANG': 'en_US.UTF-8', 07:32:43 INFO - 'LANGUAGE': 'en_US:en', 07:32:43 INFO - 'LOGNAME': 'cltbld', 07:32:43 INFO - 'MAIL': '/var/mail/cltbld', 07:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:43 INFO - 'MOZ_NO_REMOTE': '1', 07:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:43 INFO - 'NO_EM_RESTART': '1', 07:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:43 INFO - 'PWD': '/builds/slave/test', 07:32:43 INFO - 'SHELL': '/bin/bash', 07:32:43 INFO - 'SHLVL': '1', 07:32:43 INFO - 'TERM': 'linux', 07:32:43 INFO - 'TMOUT': '86400', 07:32:43 INFO - 'USER': 'cltbld', 07:32:43 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647', 07:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:43 INFO - '_': '/tools/buildbot/bin/python'} 07:32:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:43 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:32:43 INFO - Cleaning up... 07:32:43 INFO - Return code: 0 07:32:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3022bbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1944230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193e090>, '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 0x19419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1941e40>, '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': 'd2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:32:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:32:43 INFO - Using env: {'DISPLAY': ':0', 07:32:43 INFO - 'HOME': '/home/cltbld', 07:32:43 INFO - 'LANG': 'en_US.UTF-8', 07:32:43 INFO - 'LANGUAGE': 'en_US:en', 07:32:43 INFO - 'LOGNAME': 'cltbld', 07:32:43 INFO - 'MAIL': '/var/mail/cltbld', 07:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:43 INFO - 'MOZ_NO_REMOTE': '1', 07:32:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:43 INFO - 'NO_EM_RESTART': '1', 07:32:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:43 INFO - 'PWD': '/builds/slave/test', 07:32:43 INFO - 'SHELL': '/bin/bash', 07:32:43 INFO - 'SHLVL': '1', 07:32:43 INFO - 'TERM': 'linux', 07:32:43 INFO - 'TMOUT': '86400', 07:32:43 INFO - 'USER': 'cltbld', 07:32:43 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647', 07:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:43 INFO - '_': '/tools/buildbot/bin/python'} 07:32:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:44 INFO - Downloading/unpacking blobuploader==1.2.4 07:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:45 INFO - Downloading blobuploader-1.2.4.tar.gz 07:32:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:32:46 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:32:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:46 INFO - Downloading docopt-0.6.1.tar.gz 07:32:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:32:46 INFO - Installing collected packages: blobuploader, requests, docopt 07:32:46 INFO - Running setup.py install for blobuploader 07:32:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:32:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:32:46 INFO - Running setup.py install for requests 07:32:47 INFO - Running setup.py install for docopt 07:32:47 INFO - Successfully installed blobuploader requests docopt 07:32:47 INFO - Cleaning up... 07:32:47 INFO - Return code: 0 07:32:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:47 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 0x7f3022bbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1944230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193e090>, '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 0x19419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1941e40>, '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': 'd2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:32:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:32:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:32:47 INFO - Using env: {'DISPLAY': ':0', 07:32:47 INFO - 'HOME': '/home/cltbld', 07:32:47 INFO - 'LANG': 'en_US.UTF-8', 07:32:47 INFO - 'LANGUAGE': 'en_US:en', 07:32:47 INFO - 'LOGNAME': 'cltbld', 07:32:47 INFO - 'MAIL': '/var/mail/cltbld', 07:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:47 INFO - 'MOZ_NO_REMOTE': '1', 07:32:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:47 INFO - 'NO_EM_RESTART': '1', 07:32:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:47 INFO - 'PWD': '/builds/slave/test', 07:32:47 INFO - 'SHELL': '/bin/bash', 07:32:47 INFO - 'SHLVL': '1', 07:32:47 INFO - 'TERM': 'linux', 07:32:47 INFO - 'TMOUT': '86400', 07:32:47 INFO - 'USER': 'cltbld', 07:32:47 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647', 07:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:47 INFO - '_': '/tools/buildbot/bin/python'} 07:32:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:32:47 INFO - Running setup.py (path:/tmp/pip-4udOwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:32:47 INFO - Running setup.py (path:/tmp/pip-2AJu7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:32:47 INFO - Running setup.py (path:/tmp/pip-itUmDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:32:47 INFO - Running setup.py (path:/tmp/pip-dO3TW7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:32:47 INFO - Running setup.py (path:/tmp/pip-uHJlDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:32:47 INFO - Running setup.py (path:/tmp/pip-rIwGvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:32:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:32:47 INFO - Running setup.py (path:/tmp/pip-i7_oy7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:32:48 INFO - Running setup.py (path:/tmp/pip-Nw2VNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:32:48 INFO - Running setup.py (path:/tmp/pip-pK7Xjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:32:48 INFO - Running setup.py (path:/tmp/pip-aljRcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:32:48 INFO - Running setup.py (path:/tmp/pip-Voi86Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:32:48 INFO - Running setup.py (path:/tmp/pip-qapdMW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:32:48 INFO - Running setup.py (path:/tmp/pip-hPwiYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:32:48 INFO - Running setup.py (path:/tmp/pip-0IlSJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:48 INFO - Running setup.py (path:/tmp/pip-dbdpcO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:32:48 INFO - Running setup.py (path:/tmp/pip-hQms17-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:32:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:32:48 INFO - Running setup.py (path:/tmp/pip-tLmIL3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:32:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:32:48 INFO - Running setup.py install for manifestparser 07:32:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:32:48 INFO - Running setup.py install for mozcrash 07:32:48 INFO - Running setup.py install for mozdebug 07:32:49 INFO - Running setup.py install for mozdevice 07:32:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:32:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:32:49 INFO - Running setup.py install for mozfile 07:32:49 INFO - Running setup.py install for mozhttpd 07:32:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:32:49 INFO - Running setup.py install for mozinfo 07:32:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:32:49 INFO - Running setup.py install for mozInstall 07:32:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:32:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:32:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:32:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:32:49 INFO - Running setup.py install for mozleak 07:32:49 INFO - Running setup.py install for mozlog 07:32:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:32:49 INFO - Running setup.py install for moznetwork 07:32:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:32:49 INFO - Running setup.py install for mozprocess 07:32:50 INFO - Running setup.py install for mozprofile 07:32:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:32:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:32:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:32:50 INFO - Running setup.py install for mozrunner 07:32:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:32:50 INFO - Running setup.py install for mozscreenshot 07:32:50 INFO - Running setup.py install for moztest 07:32:50 INFO - Running setup.py install for mozversion 07:32:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:32:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:32:50 INFO - Cleaning up... 07:32:50 INFO - Return code: 0 07:32:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:50 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 0x7f3022bbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1944230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193e090>, '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 0x19419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1941e40>, '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': 'd2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:32:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:32:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:32:50 INFO - Using env: {'DISPLAY': ':0', 07:32:50 INFO - 'HOME': '/home/cltbld', 07:32:50 INFO - 'LANG': 'en_US.UTF-8', 07:32:50 INFO - 'LANGUAGE': 'en_US:en', 07:32:50 INFO - 'LOGNAME': 'cltbld', 07:32:50 INFO - 'MAIL': '/var/mail/cltbld', 07:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:50 INFO - 'MOZ_NO_REMOTE': '1', 07:32:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:50 INFO - 'NO_EM_RESTART': '1', 07:32:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:50 INFO - 'PWD': '/builds/slave/test', 07:32:50 INFO - 'SHELL': '/bin/bash', 07:32:50 INFO - 'SHLVL': '1', 07:32:50 INFO - 'TERM': 'linux', 07:32:50 INFO - 'TMOUT': '86400', 07:32:50 INFO - 'USER': 'cltbld', 07:32:50 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647', 07:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:50 INFO - '_': '/tools/buildbot/bin/python'} 07:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:32:50 INFO - Running setup.py (path:/tmp/pip-VD8WMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:32:50 INFO - Running setup.py (path:/tmp/pip-2t4pc3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:32:50 INFO - Running setup.py (path:/tmp/pip-FRoMzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:32:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:32:51 INFO - Running setup.py (path:/tmp/pip-jEmRf0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:32:51 INFO - Running setup.py (path:/tmp/pip-HZAmUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:32:51 INFO - Running setup.py (path:/tmp/pip-qA0WC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:32:51 INFO - Running setup.py (path:/tmp/pip-yIyV2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:32:51 INFO - Running setup.py (path:/tmp/pip-t6MCoU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:32:51 INFO - Running setup.py (path:/tmp/pip-EIYUq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:32:51 INFO - Running setup.py (path:/tmp/pip-srmLz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:32:51 INFO - Running setup.py (path:/tmp/pip-_JXYt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:32:51 INFO - Running setup.py (path:/tmp/pip-GODPOp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:32:51 INFO - Running setup.py (path:/tmp/pip-3rGRpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:32:51 INFO - Running setup.py (path:/tmp/pip-N1reC0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:51 INFO - Running setup.py (path:/tmp/pip-Rk0RGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:32:51 INFO - Running setup.py (path:/tmp/pip-s8VLun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:32:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:32:51 INFO - Running setup.py (path:/tmp/pip-aqGnOq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:32:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:32:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:32:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:32:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:32:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:32:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:32:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:32:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:32:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:32:53 INFO - Downloading blessings-1.6.tar.gz 07:32:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:32:53 INFO - Installing collected packages: blessings 07:32:53 INFO - Running setup.py install for blessings 07:32:54 INFO - Successfully installed blessings 07:32:54 INFO - Cleaning up... 07:32:54 INFO - Return code: 0 07:32:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:32:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:32:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:32:54 INFO - Reading from file tmpfile_stdout 07:32:54 INFO - Current package versions: 07:32:54 INFO - argparse == 1.2.1 07:32:54 INFO - blessings == 1.6 07:32:54 INFO - blobuploader == 1.2.4 07:32:54 INFO - docopt == 0.6.1 07:32:54 INFO - functools32 == 3.2.3-2 07:32:54 INFO - jsonschema == 2.5.1 07:32:54 INFO - manifestparser == 1.1 07:32:54 INFO - mozInstall == 1.12 07:32:54 INFO - mozcrash == 0.17 07:32:54 INFO - mozdebug == 0.1 07:32:54 INFO - mozdevice == 0.48 07:32:54 INFO - mozfile == 1.2 07:32:54 INFO - mozhttpd == 0.7 07:32:54 INFO - mozinfo == 0.9 07:32:54 INFO - mozleak == 0.1 07:32:54 INFO - mozlog == 3.3 07:32:54 INFO - moznetwork == 0.27 07:32:54 INFO - mozprocess == 0.23 07:32:54 INFO - mozprofile == 0.28 07:32:54 INFO - mozrunner == 6.12 07:32:54 INFO - mozscreenshot == 0.1 07:32:54 INFO - mozsystemmonitor == 0.3 07:32:54 INFO - moztest == 0.7 07:32:54 INFO - mozversion == 1.4 07:32:54 INFO - psutil == 3.1.1 07:32:54 INFO - requests == 1.2.3 07:32:54 INFO - wsgiref == 0.1.2 07:32:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:32: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')]} 07:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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')]} 07:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32:54 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 0x7f3022bbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1944230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193e090>, '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 0x19419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1941e40>, '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': 'd2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:32:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:32:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:32:54 INFO - Using env: {'DISPLAY': ':0', 07:32:54 INFO - 'HOME': '/home/cltbld', 07:32:54 INFO - 'LANG': 'en_US.UTF-8', 07:32:54 INFO - 'LANGUAGE': 'en_US:en', 07:32:54 INFO - 'LOGNAME': 'cltbld', 07:32:54 INFO - 'MAIL': '/var/mail/cltbld', 07:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:54 INFO - 'MOZ_NO_REMOTE': '1', 07:32:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:54 INFO - 'NO_EM_RESTART': '1', 07:32:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:54 INFO - 'PWD': '/builds/slave/test', 07:32:54 INFO - 'SHELL': '/bin/bash', 07:32:54 INFO - 'SHLVL': '1', 07:32:54 INFO - 'TERM': 'linux', 07:32:54 INFO - 'TMOUT': '86400', 07:32:54 INFO - 'USER': 'cltbld', 07:32:54 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647', 07:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:54 INFO - '_': '/tools/buildbot/bin/python'} 07:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:32:54 INFO - Cleaning up... 07:32:54 INFO - Return code: 0 07:32:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:32: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')]} 07:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:32:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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')]} 07:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:32:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:32: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3022bbaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18758a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1944230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x193e090>, '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 0x19419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1941e40>, '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': 'd2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:32: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', 'jsonschema'] in /builds/slave/test/build 07:32: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 jsonschema 07:32:54 INFO - Using env: {'DISPLAY': ':0', 07:32:54 INFO - 'HOME': '/home/cltbld', 07:32:54 INFO - 'LANG': 'en_US.UTF-8', 07:32:54 INFO - 'LANGUAGE': 'en_US:en', 07:32:54 INFO - 'LOGNAME': 'cltbld', 07:32:54 INFO - 'MAIL': '/var/mail/cltbld', 07:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:32:54 INFO - 'MOZ_NO_REMOTE': '1', 07:32:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:32:54 INFO - 'NO_EM_RESTART': '1', 07:32:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:32:54 INFO - 'PWD': '/builds/slave/test', 07:32:54 INFO - 'SHELL': '/bin/bash', 07:32:54 INFO - 'SHLVL': '1', 07:32:54 INFO - 'TERM': 'linux', 07:32:54 INFO - 'TMOUT': '86400', 07:32:54 INFO - 'USER': 'cltbld', 07:32:54 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647', 07:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:32:54 INFO - '_': '/tools/buildbot/bin/python'} 07:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:32:54 INFO - Cleaning up... 07:32:54 INFO - Return code: 0 07:32:54 INFO - Running post-action listener: _resource_record_post_action 07:32:54 INFO - Running post-action listener: _start_resource_monitoring 07:32:54 INFO - Starting resource monitoring. 07:32:54 INFO - [mozharness: 2016-08-18 14:32:54.810331Z] Finished create-virtualenv step (success) 07:32:54 INFO - [mozharness: 2016-08-18 14:32:54.810836Z] Running install step. 07:32:54 INFO - Running pre-action listener: _resource_record_pre_action 07:32:54 INFO - Running main action method: install 07:32:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:32:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:32:55 INFO - Reading from file tmpfile_stdout 07:32:55 INFO - Detecting whether we're running mozinstall >=1.0... 07:32:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:32:55 INFO - Reading from file tmpfile_stdout 07:32:55 INFO - Output received: 07:32:55 INFO - Usage: mozinstall [options] installer 07:32:55 INFO - Options: 07:32:55 INFO - -h, --help show this help message and exit 07:32:55 INFO - -d DEST, --destination=DEST 07:32:55 INFO - Directory to install application into. [default: 07:32:55 INFO - "/builds/slave/test"] 07:32:55 INFO - --app=APP Application being installed. [default: firefox] 07:32:55 INFO - mkdir: /builds/slave/test/build/application 07:32:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:32:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:33:11 INFO - Reading from file tmpfile_stdout 07:33:11 INFO - Output received: 07:33:11 INFO - /builds/slave/test/build/application/firefox/firefox 07:33:11 INFO - Running post-action listener: _resource_record_post_action 07:33:11 INFO - [mozharness: 2016-08-18 14:33:11.199303Z] Finished install step (success) 07:33:11 INFO - [mozharness: 2016-08-18 14:33:11.199552Z] Running run-tests step. 07:33:11 INFO - Running pre-action listener: _resource_record_pre_action 07:33:11 INFO - Running main action method: run_tests 07:33:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:33:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:33:11 INFO - Python 2.7.3 07:33:11 INFO - Return code: 0 07:33:11 INFO - grabbing minidump binary from tooltool 07:33:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:33:11 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 0x193e090>, '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 0x19419b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1941e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:33:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:33:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:33:11 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:33:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:33:11 INFO - Return code: 0 07:33:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:33:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:33:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:33:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:33:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:33:11 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/NoVgWCbsTP-c-cfWDxoJow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:33:11 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/NoVgWCbsTP-c-cfWDxoJow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-043 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:33:11 INFO - Using env: {'DISPLAY': ':0', 07:33:11 INFO - 'HOME': '/home/cltbld', 07:33:11 INFO - 'LANG': 'en_US.UTF-8', 07:33:11 INFO - 'LANGUAGE': 'en_US:en', 07:33:11 INFO - 'LOGNAME': 'cltbld', 07:33:11 INFO - 'MAIL': '/var/mail/cltbld', 07:33:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:33:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:33:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:33:11 INFO - 'MOZ_NO_REMOTE': '1', 07:33:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:33:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:33:11 INFO - 'NO_EM_RESTART': '1', 07:33:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:33:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:33:11 INFO - 'PWD': '/builds/slave/test', 07:33:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:33:11 INFO - 'SHELL': '/bin/bash', 07:33:11 INFO - 'SHLVL': '1', 07:33:11 INFO - 'TERM': 'linux', 07:33:11 INFO - 'TMOUT': '86400', 07:33:11 INFO - 'USER': 'cltbld', 07:33:11 INFO - 'XDG_SESSION_COOKIE': 'd2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647', 07:33:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:33:11 INFO - '_': '/tools/buildbot/bin/python'} 07:33:11 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/NoVgWCbsTP-c-cfWDxoJow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-043', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:33:11 INFO - mozversion application_buildid: 20160817220715 07:33:11 INFO - mozversion application_changeset: d0efbd7c33fe76c4dfd70dbd204b158cc482ec52 07:33:11 INFO - mozversion application_display_name: Nightly 07:33:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:33:11 INFO - mozversion application_name: Firefox 07:33:11 INFO - mozversion application_remotingname: firefox 07:33:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 07:33:11 INFO - mozversion application_vendor: Mozilla 07:33:11 INFO - mozversion application_version: 51.0a1 07:33:11 INFO - mozversion platform_buildid: 20160817220715 07:33:11 INFO - mozversion platform_changeset: d0efbd7c33fe76c4dfd70dbd204b158cc482ec52 07:33:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 07:33:11 INFO - mozversion platform_version: 51.0a1 07:33:11 INFO - using testdate: 1471530791 07:33:11 INFO - actual date: 1471530791 07:33:11 INFO - starting webserver on 'localhost:34830' 07:33:11 INFO - SUITE-START | Running 2 tests 07:33:11 INFO - TEST-START | dromaeo_css 07:33:11 INFO - operating with platform_type : linux_ 07:33:11 INFO - Initialising browser for dromaeo_css test... 07:33:11 INFO - TEST-INFO | started process 11009 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6eAQrE/profile http://localhost:34830/getInfo.html) 07:33:15 INFO - PROCESS | 11009 | __metrics Screen width/height:1600/1200 07:33:15 INFO - PROCESS | 11009 | colorDepth:24 07:33:15 INFO - PROCESS | 11009 | Browser inner width/height: 1024/697 07:33:15 INFO - PROCESS | 11009 | __metrics 07:33:16 INFO - PROCESS | 11009 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:33:16 INFO - PROCESS | 11009 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:33:16 INFO - PROCESS | 11009 | console.error: PushService: 07:33:16 INFO - PROCESS | 11009 | stateChangeProcessEnqueue: Error transitioning state 07:33:16 INFO - PROCESS | 11009 | UnknownError 07:33:17 INFO - TEST-INFO | 11009: exit 0 07:33:17 INFO - Browser initialized. 07:33:17 INFO - Running cycle 1/1 for dromaeo_css test... 07:33:17 INFO - TEST-INFO | started process 11089 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6eAQrE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:33:29 INFO - PROCESS | 11089 | RSS: Main: 157736960 07:33:29 INFO - PROCESS | 11089 | 07:34:20 INFO - PROCESS | 11089 | 1471530860602 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:36:33 INFO - PROCESS | 11089 | Cycle 1(1): loaded http://localhost:34830/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34830/tests/dromaeo/cssquery-ext.html) 07:36:34 INFO - PROCESS | 11089 | RSS: Main: 243564544 07:36:34 INFO - PROCESS | 11089 | 07:39:37 INFO - PROCESS | 11089 | Cycle 1(1): loaded http://localhost:34830/tests/dromaeo/cssquery-ext.html (next: http://localhost:34830/tests/dromaeo/cssquery-jquery.html) 07:39:38 INFO - PROCESS | 11089 | RSS: Main: 245567488 07:39:38 INFO - PROCESS | 11089 | 07:42:40 INFO - PROCESS | 11089 | Cycle 1(1): loaded http://localhost:34830/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34830/tests/dromaeo/cssquery-mootools.html) 07:42:40 INFO - PROCESS | 11089 | RSS: Main: 230846464 07:42:40 INFO - PROCESS | 11089 | 07:45:43 INFO - PROCESS | 11089 | Cycle 1(1): loaded http://localhost:34830/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34830/tests/dromaeo/cssquery-prototype.html) 07:45:43 INFO - PROCESS | 11089 | RSS: Main: 193306624 07:45:43 INFO - PROCESS | 11089 | 07:48:46 INFO - PROCESS | 11089 | Cycle 1(1): loaded http://localhost:34830/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34830/tests/dromaeo/cssquery-yui.html) 07:48:47 INFO - PROCESS | 11089 | RSS: Main: 189313024 07:48:47 INFO - PROCESS | 11089 | 07:51:50 INFO - PROCESS | 11089 | Cycle 1(1): loaded http://localhost:34830/tests/dromaeo/cssquery-yui.html (next: http://localhost:34830/tests/dromaeo/cssquery-dojo.html) 07:51:50 INFO - PROCESS | 11089 | RSS: Main: 281702400 07:51:50 INFO - PROCESS | 11089 | 07:51:50 INFO - PROCESS | 11089 | __start_tp_report 07:51:50 INFO - PROCESS | 11089 | _x_x_mozilla_page_load 07:51:50 INFO - PROCESS | 11089 | _x_x_mozilla_page_load_details 07:51:50 INFO - PROCESS | 11089 | |i|pagename|runs| 07:51:50 INFO - PROCESS | 11089 | |0;dojo.html;2597.2338160242725;2613.1246032579083;2631.118575277282;2638.6701662292203;2639.907603233887;4584.97707511462;4665.3235280884255;4666.813327466902;4716.646251531136;4738.620910327174;4638.304254361839;4678.672492925497;4686.203345431276;4693.50718174591;4741.407324084489;4249.6387807036435;4260.446142001551;4349.282368409209;4398.098389830077;4470.128324976631;4379.802908869108;4422.579854913794;4429.003474218292;4442.3558584005295;4456.286994080948;4222.85220017301;4227.852025179135;4244.851430199959;4271.9359209611885;4274.422952901349;4277.97861010696;4280.700350975433;4282.678799090049;4313.676474264411;4371.4098596689355;4296.31480324797;4311.935320970188;4312.63342615878;4313.029568347129;4364.934525982081;4553.772311384418;4609.516000819933;4626.7223966562115;4712.340272361872;4762.97596016858;5017.724025178613;5028.044671512401;5035.597152227813;5058.4435712071645;5058.898822023539;5055.620828437882;5072.6195535335;5085.389753229599;5086.974565127188;5100.923486147711;4614.792334344963;4675.392199014106;4727.24364101749;4740.786664600101;4742.549457801503;5151.2273159026445;5177.585793136615;5225.921611175835;5229.058769421465;5230.215467679878;4974.7263900485095;4977.253411988231;4980;5020.196768517019;5023.874403139951;4873.390826146731;4996.125678006334;5014.598832093424;5024.120778863684;5039.4708555601865;5023.070731914608;5029.547340739351;5030.044291584587;5030.346055012825;5033.79864805411;4989.800407983713;5024.296598476216;5025.522575355335;5036.043151801146;5069.163588008011;4156.9792151039655;4196.9370459443135;4200.978995105066;4251.086016506404;4336.284513055373;3683.594804571495;3731.794751288651;3752;3771.151490914577;3818.961810381916;4319.589638984291;4320.287152619782;4321.805518751664;4329.567043295645;4375.01562148514;5024.698518088926;5033.219850923113;5033.521815427529;5044.621653375938;5057.8735531612;4126.773027483518;4247.8088486018205;4263.976645605095;4310.482742070909;4371.912561748811;4516.8193272268745;4521.932171017437;4522.977385113053;4534.410526631516;4563.748993805306;4709.128811169944;4717.9056418872115;4726.952730472652;4732.124556956974;4756.239001759633;4910.993246384412;4994.225894986283;5043.067032598981;5044.697318160922;5129.153689641167;4747.050589881968;4765.880852978703;4766.904661906673;4781.569658730592;4821.059893320768;5009.474005229398;5010.488106041429;5013.222950442687;5018.172001619692;5061.519155680205;4889.63327750413;4944.901101977868;4962.280469331855;5013.172826483589;5049.040682270357;4886.364772579542;4888.853334399973;4890.388701412324;4895.4859739728245;4939.185034469272;4875.8049678012485;4881.9511804881495;4888.9755551222015;4899;4938.08645400602;4693;4748.0503899220985;4811.398575178103;4812.085703716282;4867.659263851497;4874.4150701916;4901.852944411673;4911.557959783494;4914.115459217375;4955.876103097451;4702.224133018014;4801.303810947463;4811.975940120277;4812.5668689818085;4860.3681521403405 07:51:50 INFO - PROCESS | 11089 | |1;ext.html;552.4144406928658;561.4497792163679;562.8649124210191;571.0691572736441;575.4217011903037;28256.43487130256;37975;39568.80215598925;39592.802035989815;42873.285068597215;41000.38499422511;41493.58506414935;41496.58503414965;41512;41531.377029344505;7586;7720.61396930154;7732.226777322251;7733.922660773376;7735.1491335953;7675.846483070335;7743.7676869694;7780.183080776522;7782.027246594176;7788.06543214815;7783.610819459032;7786.454948153631;7822.843543129134;7833.334166595846;7836.647350869224;7739.458237923348;7780.610969451504;7781.41639377049;7781.610919454005;7785.8053548661455;7598.44231932458;7662.272084151997;7662.387009039264;7664.846703065963;7702.268284512962;26472.73527264722;26649.333766655796;26688.73311266882;26699.866500667566;26712.198634040815;3007.3083190866005;3021.1993821637284;3027.6215473065868;3034.2884445823815;3044.147638661156;26231;28689.159153909422;29176;29239.70760292391;29966.101016969307;3322.9169270768425;3397.643247459006;3407.8296085195643;3434.9484757728405;3459.636738142484;258972.705136475;259746;259829;260441.9999999981;260534;51472.74263628658;51748;51839.22241166385;51880;51902.22146667803;32425.837870810967;33335.333293334;33576.49635255473;53051;53216;13676.632336766244;13893.374798134108;13943.790843137362;14016.85983140176;14134.717305653829;10257.794844103077;10350;10375.481225938824;10389.480525973671;10397.428141452292;17982.460526184237;17985.55036124081;18026.909865450853;18029.926558445684;18070;6772.424343930723;6793.864122717518;6830.496415084021;6904.240533541307;7025.543339682904;752.5860776572863;817.8323443694028;956.6269155029544;968.1577027985697;971.718201721507;27296.863515682293;27313.371228509935;27859.796123445656;28087;28492.71507284942;834.6411043251338;891.6166048599035;913.1735779119907;922.8754118193958;946.9384490008127;13405.932970335087;14096.295185240697;14115.505957291445;14279.92860035714;14494.202818844853;379055;383478;383494;383686;384225;48349;48670.75664621654;49048;49061.26408103881;49074.75462622664;1038.745507350704;1106.905912997372;1115.7489564847845;1174.1956759619688;1194.211820198682;25433.491330173663;29363.41273174482;29451.41097178087;29803.85098074496;29898.85050574733;40213.195736084526;41183;41198.38202427026;41241;41259.38110928398;236036;236731;236731;237142;237213;21945.451363716034;24305.75694243035;25224.495510090062;25520.361990950376;25578.74421255838;38525.42211866768;38903.80548097355;41992.370114447695;42020;42065.57934420617;35191.47212791861;35348.646513534535;35642.821785890905;35897.820510897276;36108;34475.4828677565;35089.298214036084;35421;35730;36152;26886.462270754084;34609.826950865085;35152;35210.647893520734;35937.82031089828;30905.381892361576;31914.36171276608;32629.18427039343;33417;33729.66270337364;25246.495070098863;25706.614400784376;25742.742572574036;25750.613740794277;25912.61131083073 07:51:50 INFO - PROCESS | 11089 | |2;jquery.html;344.8739864342919;361.784738080842;363.63454727998356;365.77504834526763;380.39327272999554;12566.371681415927;13472.730545389086;14013.719725605495;16844.24200910959;16847.74728379075;15126.168060756654;15277.61805954849;15832.366705331802;15917.681646367066;15995.360185592563;4567.634589232862;4691.437027556698;4705.505921878204;4706.176419126657;4713.245880659095;3433.3305005523935;5617.354004289518;5823.126531020339;5883.117532370157;5959.374265702104;5678.233438485813;5912.7930522431725;5922.200502932092;5925.140854576105;5927.851803704921;5809.3609702932645;5839.065749480105;5840.211571437865;5853.678047707374;5869.735861886183;5128.512791284822;5200.869978250536;5211.843644690665;5222.164453687392;5277.3139491866195;12376.504939802397;12448.688782780413;18571.62856742871;20880.895595521924;21033.579328413347;1745.3106023120922;1833.1292635997927;1884.148704647764;2193.5503221839485;2286.4969706664506;8591.484510929364;9227.630894764201;9395.201407880339;9542.618295268181;9642.662506812228;1640.8441198086164;1714.3999600139975;1722.1991773825232;1738.226489212301;1793.4619614115713;66346.66826665885;66777.66611166912;67868.6606566964;69022;72360.6381968092;9839.704808855746;10012.299139060196;10107.595696172071;10178.541965611565;10402.27184097121;13735.862641373658;13746.65633359174;13849.16904985704;13898.444062237397;13915.30423478822;6995.545289556163;7161.176464706626;7200.747973820891;7272.05463289769;7325.6337183141695;6587.473002159816;6588.73645054202;6721.092652491949;6768.323167683291;6856;4302.118065796504;4314.61168494837;4333.068390296102;4341.739495630272;4449;1790.7851057872879;1813.5322004157476;1894.658961386936;1923.249932526316;1923.7210604462275;818.1532114261711;854.2311919272704;867.1761826265074;877.7059685005466;920.0845159066771;16434.17829108564;16567.088810115558;16701.49895503137;17354.39259625907;17967.371142009968;841.7011960753966;852.3436953545735;868.774118729135;871.1941454154882;920.7744102694749;9229.584668689926;10031.29780915329;10109.443980581138;10212.744681382876;10228.948855255825;398365;401792;404924;413258;414097;50061;65990;77495.61252193703;81200.59399702963;83845.58077209575;837.698428565728;846.3821410370341;847.1486156412766;849.1720572441819;856.0198572634423;15688.137152456267;15740.134292614017;15937.601559961095;16009.279582418587;16282;36645.63354366422;37749.54627949175;38739.41890871583;39033.2193356137;39413;48625;51428.48571514237;51728.741356294486;52027;53797;7578.09062912454;7634.549435607217;7680.193579674277;7844.4901081429525;8216.34269258446;9824.852627210455;10913.508892100033;11038.779224415628;11902.464389102339;12236.816447753114;9863.21094312439;9883.55524001436;10006.249531285037;10227.130693891102;10593.629222977159;10144.188464922641;10198.745031374276;10288.331258468175;10522.053015228666;10527.368357898551;9799.51002449889;9832.754181145528;10043.849342259726;10194.286399951932;10507.632232871812;7732.536047837148;7770.300672939463;7842.686292548462;7855.293023627901;8030.277275045274;8882.245009174292;9765.365251258645;10064.245181611263;10082.949585252027;10314.845277320996 07:51:50 INFO - PROCESS | 11089 | |3;mootools.html;1217.957371491998;1372.0464277327258;1401.0052862467649;1468.5224114054577;1664.4257731082773;6486.091947127406;7426.888596671048;7752.186020467854;7765.572893490856;8000.759977200679;7838.529688218711;7900.6444709988045;7910.327622152109;7917.287444130027;7922.128565857765;2167.111484291441;2186.2020362567628;2190.6494960806276;2192.7039849620255;2193.747719012318;2147.334326358826;2186.7485239197536;2202.691623172749;2204.1403852497538;2205.2612374854443;2151.268568686646;2154.472154322193;2158.3740715192575;2164.5346250556127;2204.360735386736;2114.598226336991;2119.459537817854;2122.066290832029;2123.076461739133;2129.7124888140133;2058.835293176557;2136.861104028233;2136.8611040282485;2139.6255655260425;2146.8389870759756;7607.277308655669;7664.540127592307;7756.961215193945;7763.068431788165;7850.057993040871;4306.978465107686;4476.55234476553;4488.079943611552;4493.146302202571;4493.68544201906;2761.144045345949;2913.9271518212004;2966.258435391152;2968.495355789499;2975.3156773942114;900.7793090692757;907.3240435875315;928.0580211085753;928.0580211085753;928.071928071928;10360.171186305077;10430.791384172275;10461.738456538571;10472.057514823626;10477.161827053817;3928.7642741435607;4064.248114098901;4216.430781844411;4223.408722778813;4236.131593023423;8338.749837504885;8342.958285208657;8351.415400921998;8353.20644538768;8360.958195208985;4441.111777644484;4441.578050085237;4445.088756804847;4446.911061778746;4448.110377924363;3567.7324200685052;3991.900202494961;4111.6916231282175;4139.068709540389;4141.8964525886495;3436.570428696413;3465.9653403466145;3578.427451607782;3581.94627080594;3590.9281814363567;1047.554789214596;1061.9415932123807;1071.3357718214756;1074.6399956014666;1081.8755843078147;756.1984296645574;822.9341652667772;839.0812060793421;852.6845067325005;862.3790870573177;5379.220013098157;5530.889382212414;5576.302962129734;5638;5756.856078598069;795.9044914610283;818.2758258940761;835.5655059369094;861.2205953611866;895.8700988356652;3746.925061498755;3869.4776205212497;3873.12854607711;3930.744501607386;3934.3672375963656;9583;9723.708288751348;9853;9968.152707019985;9985.350952188084;9645;9651.276154288316;9653.662121825842;9678.322517423712;9698.51507424626;7179.066721326194;7316.743913963092;7319.15829679583;7322.340989310987;7334.9266507335315;5132.30713853625;5462.754176062007;5465.480779325958;5584.972075139598;5735.369109398046;8794.252488538546;8882.378233523592;8944.955275223581;9062.365634405529;9107.863382049141;9192.49441280736;9294.117058879396;9294.302927280345;9295.76760580991;9306.06939306064;5808.535317174531;6190.442860142609;6390.265119511316;6545.247296560766;6553.705083271169;7129.928700712927;7375.336219740249;7381.667824947997;7398.667059982421;7406.296401841816;6597.934020659924;6669.566043300713;6670.599764014175;6821.863562728817;6861.519693621399;6379.362063793769;6381.87236255263;6432.903506447314;6455.354464553507;6461.06314584392;6307.400796924285;6390.105385245976;6394;6396.712147953446;6407.3592640737415;4616.353710480468;4657.813687452464;4752.477227505041;4764.595009424238;4779.402574678165;4577.610903073276;4631.8378856739855;4643.930341044955;4695.741734204515;4945.77744001528 07:51:50 INFO - PROCESS | 11089 | |4;prototype.html;282.7935607006886;296.1367613406919;298.96412430508343;300.81199250468455;301.9924501887454;4827.806887724487;4880.755962201893;4889.291052797343;4889.853304400869;4892.290617860417;4553.7704819698665;4647.302904564317;4689.835855745049;4720.221163508026;4832.4684284728655;3815.0433414104014;3815.389537673973;3816.3893776995687;3821.5414150301863;3823.5985221551755;3811.7331786774935;3824.9426258606145;3829.6553310202216;3832.712546559005;3857.749246298996;3602.5676918769655;3610.6569875861883;3703.0558956547757;3784.8107594620296;3800.163963927945;3764.153065560227;3767.5699174032598;3767.642074002979;3770.1894092770185;3770.679492243149;3332.9834400507834;3347.916302092443;3350.2294472271515;3350.547676063725;3355.724824566649;4466.240739074366;4710.317004034396;4710.69380490267;4720.905581888377;4763.857084287477;4302.978485107586;4332.1119170569955;4335.6965012449145;4339.349097635349;4352.260115780293;5074.594032477393;5086.516780905808;5095.388553373619;5096.898062038738;5114.923276150861;3699.72252081095;3702.9259414811554;3706.5737440194184;3708.796016219107;3715.405535114369;5142.640015198937;5272.340957380327;5283.365996080495;5283.682979021271;5318.282031925679;3708.9814550927613;3713.1459764254373;3717.4052151656147;3728.813559322023;3733.7386382953478;3802.1255111324;3806.809659517013;3807.8667246646787;3826.712996525216;3828.1386687994977;4236.428082208924;4253.820551865805;4294.9785251073545;4336.783160841946;4348.434703488526;5077.543021128116;5082.67850358902;5090.949090509048;5095.834270435124;5098.821541246039;1265.3862876504888;1337.1976813911576;1341.4298922957703;1349.865013498662;1353.8916886649044;896.1755185229605;908.9590968406437;926.8980412154658;933.696548621687;934.8784657994418;4418.977905110518;4431.246688063037;4438.511763706054;4439.755813430293;4445.644078556007;5146.716930568779;5159;5161.793528258828;5194.7272918135295;5206.214675148777;4341.9565804341555;4412.646988240933;4418.248897687401;4426.84506042287;4466.4640243171025;2732.4808286425514;2744.533429317021;2746.931326716808;2747.3406382468465;2750.3949131191107;4816.434658735925;4850.272459131088;4864.927026094611;4868.610511159099;4873.731944743073;5037.5214354636255;5196.350456192976;5255.605829562798;5272.789088436496;5292.761825717852;4824.42992185787;4837.105135549864;4838.274258861128;4851.805927762991;4857.198562237262;5130.640855140105;5140.974295128501;5142.434332223527;5145.871353216199;5165.741712914264;4886.921239619017;5006.924896126634;5017.949820501748;5050.520200580939;5062.493750624908;4837.637177211794;4842.854714358575;4843.539863712942;4844.806207751651;4846.224604063333;3779.7732136071922;3791.1659434924272;3806.904827379227;3808.4477750725437;3812.941011853568;4889.779959901742;5091.261767043832;5104.259882317117;5146.716930568855;5157.174852023658;4949.020391843292;4949.208126699711;4969.887797685897;4981.975090124526;4999.575121090472;4994.400671919393;5001.699898006132;5002.299678045004;5019.347484826949;5029.597632189343;4688.789004494738;4768.713877167381;4964.765855365028;4979.203327467588;5030.698158110525;4958.628102892226;5075.87310317245;5107.471801458302;5108.770105345343;5125.4362020177;4976.30331753562;4976.8755781105765;4987.750612469435;4988.226824842155;4992.825251116194 07:51:50 INFO - PROCESS | 11089 | |5;yui.html;606.4462251207921;640.094266612743;659.4394764450218;703.2018658822235;718.9568625882446;11659.70850728731;12722;12726.300053497054;12773.872261277384;12784.936075319622;12256.26462412256;12353;12353.567625133122;12363.134580579363;12371.566995155172;615.6952308607223;737.8561180569791;745.899303594016;767.3630886364305;769.4613770360742;777.5567926282022;778.3850757901251;780.4263866058471;780.5238804329383;781.0237203495631;827.735124760077;830.4187069051658;830.4394533689765;830.6096134816627;830.8421399934024;650.5933791380387;785.1089013969157;805.3315747929205;810.9959450202771;816.8978877640295;595.2648479128273;595.4224402329734;595.499780184647;598.4673640459994;599.5084031094505;11884.584039558575;11945.283283003047;11958;11987.340696261703;12012.63962081139;11350.772984540345;11727.472263748152;12272.447739851728;12306.200096993667;12712.618621441372;10643.84034239487;10657.147428205724;10678.51946662402;10741.731456713567;10856.511456984455;3994.380870964976;4044.3933409988445;4048.9392659110135;4054.9594504054876;4209.431726716915;60899.69550152265;61934;63457.68271158661;64588.3541164587;65266.3473365265;9679.758006049906;9742.707718768448;9822.26333025026;9974.601015959426;10013.29906906524;15250.161241131622;15680.137592432526;15706.607334816721;15894.52316430509;19771.209151633775;6482.675866206765;6494.935050649433;6666.799996000128;6710.865782684319;6950.478714096463;3591.964080359163;3595.1191957970464;3649.4708267301094;3734.7198960078103;3737.417378047262;2965.644122705246;3094.5977022987317;3096.5664806927048;3099.02380750063;3099.7365223955767;490.8183971930337;511.0953612106625;512.7000704587858;519.8856251624636;529.684837521674;468.7281376801447;529.9136769622336;538.978440862369;561.7303694226713;581.7818318130701;7849.803754906173;8125.431219814556;8219;8358.45670031446;8541.530215838064;506.96831946987703;542.956563474921;544.2081771023152;598.4643743849231;604.9546284028628;3525.136341596325;3766.8116594170183;3911.9608803911597;3969.146633473817;4082.652974497201;103703.4814825921;106596.46701766597;110370.44814775875;110818;112505.43747281375;51417.485825142016;66080;77811.83282250771;84694.99999999876;85565;49831.750841245565;81645.59177204076;82295.5885220582;82941.92645183919;84784.57607711921;7653.770386888402;7836.804079898048;8380.748577542683;8481.787955301166;8543.829123417372;29575.704242957294;46199.45310117639;46998;47021;47935;61111.69444152751;61876.69061654663;62055.689721551105;63285.683571581845;64289.67855160694;11658.76682466363;11803.114766392384;11813.232139910879;12130.393480326125;12569.93715031419;12467.875321247035;12483.500659973499;12747;13008.463349646729;13593.388297526833;11312.886871131182;11510.251833630788;11849.111316651113;11980.460879260629;12364.62906112818;10959.397233151934;11284.266522676;11431.885681143414;12059.75880482403;12419;11193.832092518782;11485.081193504666;11932.582359617372;12264.32546209967;12271.263724176579;9711.9028809711;9964.153046991087;10063.798724025624;10183.934738300373;10325.432101234204;8484.236418722097;9050.230730387992;9145.3598248122;9346.953265233902;9421.905780942103 07:51:50 INFO - PROCESS | 11089 | __end_tp_report 07:51:50 INFO - PROCESS | 11089 | __start_cc_report 07:51:50 INFO - PROCESS | 11089 | _x_x_mozilla_cycle_collect,967 07:51:50 INFO - PROCESS | 11089 | __end_cc_report 07:51:50 INFO - PROCESS | 11089 | __startTimestamp1471531910807__endTimestamp 07:51:50 INFO - PROCESS | 11089 | 07:51:50 INFO - PROCESS | 11089 | ------- Summary: start ------- 07:51:50 INFO - PROCESS | 11089 | Number of tests: 6 07:51:50 INFO - PROCESS | 11089 | 07:51:50 INFO - PROCESS | 11089 | [#0] dojo.html Cycles:165 Average:4645.90 Median:4756.24 stddev:490.78 (10.3%) stddev-sans-first:465.23 07:51:50 INFO - PROCESS | 11089 | Values: 2597.2 2613.1 2631.1 2638.7 2639.9 4585.0 4665.3 4666.8 4716.6 4738.6 4638.3 4678.7 4686.2 4693.5 4741.4 4249.6 4260.4 4349.3 4398.1 4470.1 4379.8 4422.6 4429.0 4442.4 4456.3 4222.9 4227.9 4244.9 4271.9 4274.4 4278.0 4280.7 4282.7 4313.7 4371.4 4296.3 4311.9 4312.6 4313.0 4364.9 4553.8 4609.5 4626.7 4712.3 4763.0 5017.7 5028.0 5035.6 5058.4 5058.9 5055.6 5072.6 5085.4 5087.0 5100.9 4614.8 4675.4 4727.2 4740.8 4742.5 5151.2 5177.6 5225.9 5229.1 5230.2 4974.7 4977.3 4980.0 5020.2 5023.9 4873.4 4996.1 5014.6 5024.1 5039.5 5023.1 5029.5 5030.0 5030.3 5033.8 4989.8 5024.3 5025.5 5036.0 5069.2 4157.0 4196.9 4201.0 4251.1 4336.3 3683.6 3731.8 3752.0 3771.2 3819.0 4319.6 4320.3 4321.8 4329.6 4375.0 5024.7 5033.2 5033.5 5044.6 5057.9 4126.8 4247.8 4264.0 4310.5 4371.9 4516.8 4521.9 4523.0 4534.4 4563.7 4709.1 4717.9 4727.0 4732.1 4756.2 4911.0 4994.2 5043.1 5044.7 5129.2 4747.1 4765.9 4766.9 4781.6 4821.1 5009.5 5010.5 5013.2 5018.2 5061.5 4889.6 4944.9 4962.3 5013.2 5049.0 4886.4 4888.9 4890.4 4895.5 4939.2 4875.8 4882.0 4889.0 4899.0 4938.1 4693.0 4748.1 4811.4 4812.1 4867.7 4874.4 4901.9 4911.6 4914.1 4955.9 4702.2 4801.3 4812.0 4812.6 4860.4 07:51:50 INFO - PROCESS | 11089 | 07:51:50 INFO - PROCESS | 11089 | [#1] ext.html Cycles:180 Average:44250.62 Median:35279.65 stddev:78979.85 (223.9%) stddev-sans-first:79133.26 07:51:50 INFO - PROCESS | 11089 | Values: 552.4 561.4 562.9 571.1 575.4 28256.4 37975.0 39568.8 39592.8 42873.3 41000.4 41493.6 41496.6 41512.0 41531.4 7586.0 7720.6 7732.2 7733.9 7735.1 7675.8 7743.8 7780.2 7782.0 7788.1 7783.6 7786.5 7822.8 7833.3 7836.6 7739.5 7780.6 7781.4 7781.6 7785.8 7598.4 7662.3 7662.4 7664.8 7702.3 26472.7 26649.3 26688.7 26699.9 26712.2 3007.3 3021.2 3027.6 3034.3 3044.1 26231.0 28689.2 29176.0 29239.7 29966.1 3322.9 3397.6 3407.8 3434.9 3459.6 258972.7 259746.0 259829.0 260442.0 260534.0 51472.7 51748.0 51839.2 51880.0 51902.2 32425.8 33335.3 33576.5 53051.0 53216.0 13676.6 13893.4 13943.8 14016.9 14134.7 10257.8 10350.0 10375.5 10389.5 10397.4 17982.5 17985.6 18026.9 18029.9 18070.0 6772.4 6793.9 6830.5 6904.2 7025.5 752.6 817.8 956.6 968.2 971.7 27296.9 27313.4 27859.8 28087.0 28492.7 834.6 891.6 913.2 922.9 946.9 13405.9 14096.3 14115.5 14279.9 14494.2 379055.0 383478.0 383494.0 383686.0 384225.0 48349.0 48670.8 49048.0 49061.3 49074.8 1038.7 1106.9 1115.7 1174.2 1194.2 25433.5 29363.4 29451.4 29803.9 29898.9 40213.2 41183.0 41198.4 41241.0 41259.4 236036.0 236731.0 236731.0 237142.0 237213.0 21945.5 24305.8 25224.5 25520.4 25578.7 38525.4 38903.8 41992.4 42020.0 42065.6 35191.5 35348.6 35642.8 35897.8 36108.0 34475.5 35089.3 35421.0 35730.0 36152.0 26886.5 34609.8 35152.0 35210.6 35937.8 30905.4 31914.4 32629.2 33417.0 33729.7 25246.5 25706.6 25742.7 25750.6 25912.6 07:51:50 INFO - PROCESS | 11089 | 07:51:50 INFO - PROCESS | 11089 | [#2] jquery.html Cycles:180 Average:24471.10 Median:4395.37 stddev:66968.57 (1523.6%) stddev-sans-first:67131.94 07:51:50 INFO - PROCESS | 11089 | Values: 344.9 361.8 363.6 365.8 380.4 12566.4 13472.7 14013.7 16844.2 16847.7 15126.2 15277.6 15832.4 15917.7 15995.4 4567.6 4691.4 4705.5 4706.2 4713.2 3433.3 5617.4 5823.1 5883.1 5959.4 5678.2 5912.8 5922.2 5925.1 5927.9 5809.4 5839.1 5840.2 5853.7 5869.7 5128.5 5200.9 5211.8 5222.2 5277.3 12376.5 12448.7 18571.6 20880.9 21033.6 1745.3 1833.1 1884.1 2193.6 2286.5 8591.5 9227.6 9395.2 9542.6 9642.7 1640.8 1714.4 1722.2 1738.2 1793.5 66346.7 66777.7 67868.7 69022.0 72360.6 9839.7 10012.3 10107.6 10178.5 10402.3 13735.9 13746.7 13849.2 13898.4 13915.3 6995.5 7161.2 7200.7 7272.1 7325.6 6587.5 6588.7 6721.1 6768.3 6856.0 4302.1 4314.6 4333.1 4341.7 4449.0 1790.8 1813.5 1894.7 1923.2 1923.7 818.2 854.2 867.2 877.7 920.1 16434.2 16567.1 16701.5 17354.4 17967.4 841.7 852.3 868.8 871.2 920.8 9229.6 10031.3 10109.4 10212.7 10228.9 398365.0 401792.0 404924.0 413258.0 414097.0 50061.0 65990.0 77495.6 81200.6 83845.6 837.7 846.4 847.1 849.2 856.0 15688.1 15740.1 15937.6 16009.3 16282.0 36645.6 37749.5 38739.4 39033.2 39413.0 48625.0 51428.5 51728.7 52027.0 53797.0 7578.1 7634.5 7680.2 7844.5 8216.3 9824.9 10913.5 11038.8 11902.5 12236.8 9863.2 9883.6 10006.2 10227.1 10593.6 10144.2 10198.7 10288.3 10522.1 10527.4 9799.5 9832.8 10043.8 10194.3 10507.6 7732.5 7770.3 7842.7 7855.3 8030.3 8882.2 9765.4 10064.2 10082.9 10314.8 07:51:50 INFO - PROCESS | 11089 | 07:51:50 INFO - PROCESS | 11089 | [#3] mootools.html Cycles:180 Average:5104.23 Median:5580.64 stddev:2857.25 (51.2%) stddev-sans-first:2850.33 07:51:50 INFO - PROCESS | 11089 | Values: 1218.0 1372.0 1401.0 1468.5 1664.4 6486.1 7426.9 7752.2 7765.6 8000.8 7838.5 7900.6 7910.3 7917.3 7922.1 2167.1 2186.2 2190.6 2192.7 2193.7 2147.3 2186.7 2202.7 2204.1 2205.3 2151.3 2154.5 2158.4 2164.5 2204.4 2114.6 2119.5 2122.1 2123.1 2129.7 2058.8 2136.9 2136.9 2139.6 2146.8 7607.3 7664.5 7757.0 7763.1 7850.1 4307.0 4476.6 4488.1 4493.1 4493.7 2761.1 2913.9 2966.3 2968.5 2975.3 900.8 907.3 928.1 928.1 928.1 10360.2 10430.8 10461.7 10472.1 10477.2 3928.8 4064.2 4216.4 4223.4 4236.1 8338.7 8343.0 8351.4 8353.2 8361.0 4441.1 4441.6 4445.1 4446.9 4448.1 3567.7 3991.9 4111.7 4139.1 4141.9 3436.6 3466.0 3578.4 3581.9 3590.9 1047.6 1061.9 1071.3 1074.6 1081.9 756.2 822.9 839.1 852.7 862.4 5379.2 5530.9 5576.3 5638.0 5756.9 795.9 818.3 835.6 861.2 895.9 3746.9 3869.5 3873.1 3930.7 3934.4 9583.0 9723.7 9853.0 9968.2 9985.4 9645.0 9651.3 9653.7 9678.3 9698.5 7179.1 7316.7 7319.2 7322.3 7334.9 5132.3 5462.8 5465.5 5585.0 5735.4 8794.3 8882.4 8945.0 9062.4 9107.9 9192.5 9294.1 9294.3 9295.8 9306.1 5808.5 6190.4 6390.3 6545.2 6553.7 7129.9 7375.3 7381.7 7398.7 7406.3 6597.9 6669.6 6670.6 6821.9 6861.5 6379.4 6381.9 6432.9 6455.4 6461.1 6307.4 6390.1 6394.0 6396.7 6407.4 4616.4 4657.8 4752.5 4764.6 4779.4 4577.6 4631.8 4643.9 4695.7 4945.8 07:51:50 INFO - PROCESS | 11089 | 07:51:50 INFO - PROCESS | 11089 | [#4] prototype.html Cycles:180 Average:4195.31 Median:4792.57 stddev:1194.28 (24.9%) stddev-sans-first:1160.97 07:51:50 INFO - PROCESS | 11089 | Values: 282.8 296.1 299.0 300.8 302.0 4827.8 4880.8 4889.3 4889.9 4892.3 4553.8 4647.3 4689.8 4720.2 4832.5 3815.0 3815.4 3816.4 3821.5 3823.6 3811.7 3824.9 3829.7 3832.7 3857.7 3602.6 3610.7 3703.1 3784.8 3800.2 3764.2 3767.6 3767.6 3770.2 3770.7 3333.0 3347.9 3350.2 3350.5 3355.7 4466.2 4710.3 4710.7 4720.9 4763.9 4303.0 4332.1 4335.7 4339.3 4352.3 5074.6 5086.5 5095.4 5096.9 5114.9 3699.7 3702.9 3706.6 3708.8 3715.4 5142.6 5272.3 5283.4 5283.7 5318.3 3709.0 3713.1 3717.4 3728.8 3733.7 3802.1 3806.8 3807.9 3826.7 3828.1 4236.4 4253.8 4295.0 4336.8 4348.4 5077.5 5082.7 5090.9 5095.8 5098.8 1265.4 1337.2 1341.4 1349.9 1353.9 896.2 909.0 926.9 933.7 934.9 4419.0 4431.2 4438.5 4439.8 4445.6 5146.7 5159.0 5161.8 5194.7 5206.2 4342.0 4412.6 4418.2 4426.8 4466.5 2732.5 2744.5 2746.9 2747.3 2750.4 4816.4 4850.3 4864.9 4868.6 4873.7 5037.5 5196.4 5255.6 5272.8 5292.8 4824.4 4837.1 4838.3 4851.8 4857.2 5130.6 5141.0 5142.4 5145.9 5165.7 4886.9 5006.9 5017.9 5050.5 5062.5 4837.6 4842.9 4843.5 4844.8 4846.2 3779.8 3791.2 3806.9 3808.4 3812.9 4889.8 5091.3 5104.3 5146.7 5157.2 4949.0 4949.2 4969.9 4982.0 4999.6 4994.4 5001.7 5002.3 5019.3 5029.6 4688.8 4768.7 4964.8 4979.2 5030.7 4958.6 5075.9 5107.5 5108.8 5125.4 4976.3 4976.9 4987.8 4988.2 4992.8 07:51:50 INFO - PROCESS | 11089 | 07:51:50 INFO - PROCESS | 11089 | [#5] yui.html Cycles:180 Average:17677.56 Median:25161.28 stddev:25996.19 (103.3%) stddev-sans-first:26037.51 07:51:50 INFO - PROCESS | 11089 | Values: 606.4 640.1 659.4 703.2 719.0 11659.7 12722.0 12726.3 12773.9 12784.9 12256.3 12353.0 12353.6 12363.1 12371.6 615.7 737.9 745.9 767.4 769.5 777.6 778.4 780.4 780.5 781.0 827.7 830.4 830.4 830.6 830.8 650.6 785.1 805.3 811.0 816.9 595.3 595.4 595.5 598.5 599.5 11884.6 11945.3 11958.0 11987.3 12012.6 11350.8 11727.5 12272.4 12306.2 12712.6 10643.8 10657.1 10678.5 10741.7 10856.5 3994.4 4044.4 4048.9 4055.0 4209.4 60899.7 61934.0 63457.7 64588.4 65266.3 9679.8 9742.7 9822.3 9974.6 10013.3 15250.2 15680.1 15706.6 15894.5 19771.2 6482.7 6494.9 6666.8 6710.9 6950.5 3592.0 3595.1 3649.5 3734.7 3737.4 2965.6 3094.6 3096.6 3099.0 3099.7 490.8 511.1 512.7 519.9 529.7 468.7 529.9 539.0 561.7 581.8 7849.8 8125.4 8219.0 8358.5 8541.5 507.0 543.0 544.2 598.5 605.0 3525.1 3766.8 3912.0 3969.1 4082.7 103703.5 106596.5 110370.4 110818.0 112505.4 51417.5 66080.0 77811.8 84695.0 85565.0 49831.8 81645.6 82295.6 82941.9 84784.6 7653.8 7836.8 8380.7 8481.8 8543.8 29575.7 46199.5 46998.0 47021.0 47935.0 61111.7 61876.7 62055.7 63285.7 64289.7 11658.8 11803.1 11813.2 12130.4 12569.9 12467.9 12483.5 12747.0 13008.5 13593.4 11312.9 11510.3 11849.1 11980.5 12364.6 10959.4 11284.3 11431.9 12059.8 12419.0 11193.8 11485.1 11932.6 12264.3 12271.3 9711.9 9964.2 10063.8 10183.9 10325.4 8484.2 9050.2 9145.4 9347.0 9421.9 07:51:50 INFO - PROCESS | 11089 | -------- Summary: end -------- 07:51:50 INFO - PROCESS | 11089 | 07:51:51 INFO - TEST-INFO | 11089: exit 0 07:51:51 INFO - TEST-OK | dromaeo_css | took 1120177ms 07:51:51 INFO - TEST-START | kraken 07:51:51 INFO - operating with platform_type : linux_ 07:51:51 INFO - Initialising browser for kraken test... 07:51:51 INFO - TEST-INFO | started process 11389 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplZBCqM/profile http://localhost:34830/getInfo.html) 07:51:56 INFO - PROCESS | 11389 | __metrics Screen width/height:1600/1200 07:51:56 INFO - PROCESS | 11389 | colorDepth:24 07:51:56 INFO - PROCESS | 11389 | Browser inner width/height: 1024/697 07:51:56 INFO - PROCESS | 11389 | __metrics 07:51:56 INFO - PROCESS | 11389 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:51:56 INFO - PROCESS | 11389 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:51:57 INFO - PROCESS | 11389 | console.error: PushService: 07:51:57 INFO - PROCESS | 11389 | stateChangeProcessEnqueue: Error transitioning state 07:51:57 INFO - PROCESS | 11389 | UnknownError 07:51:58 INFO - TEST-INFO | 11389: exit 0 07:51:58 INFO - Browser initialized. 07:51:58 INFO - Running cycle 1/1 for kraken test... 07:51:58 INFO - TEST-INFO | started process 11474 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmplZBCqM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:52:09 INFO - PROCESS | 11474 | RSS: Main: 158052352 07:52:09 INFO - PROCESS | 11474 | 07:52:12 INFO - PROCESS | 11474 | Cycle 1(1): loaded http://localhost:34830/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34830/tests/kraken/driver.html?testName=audio-beat-detection) 07:52:13 INFO - PROCESS | 11474 | RSS: Main: 205426688 07:52:13 INFO - PROCESS | 11474 | 07:52:16 INFO - PROCESS | 11474 | Cycle 1(1): loaded http://localhost:34830/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34830/tests/kraken/driver.html?testName=audio-dft) 07:52:16 INFO - PROCESS | 11474 | RSS: Main: 196681728 07:52:16 INFO - PROCESS | 11474 | 07:52:20 INFO - PROCESS | 11474 | Cycle 1(1): loaded http://localhost:34830/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34830/tests/kraken/driver.html?testName=audio-fft) 07:52:20 INFO - PROCESS | 11474 | RSS: Main: 277618688 07:52:20 INFO - PROCESS | 11474 | 07:52:22 INFO - PROCESS | 11474 | Cycle 1(1): loaded http://localhost:34830/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34830/tests/kraken/driver.html?testName=audio-oscillator) 07:52:23 INFO - PROCESS | 11474 | RSS: Main: 188088320 07:52:23 INFO - PROCESS | 11474 | 07:52:25 INFO - PROCESS | 11474 | Cycle 1(1): loaded http://localhost:34830/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34830/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:52:26 INFO - PROCESS | 11474 | RSS: Main: 192077824 07:52:26 INFO - PROCESS | 11474 | 07:52:29 INFO - PROCESS | 11474 | Cycle 1(1): loaded http://localhost:34830/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34830/tests/kraken/driver.html?testName=imaging-darkroom) 07:52:30 INFO - PROCESS | 11474 | RSS: Main: 228491264 07:52:30 INFO - PROCESS | 11474 | 07:52:33 INFO - PROCESS | 11474 | Cycle 1(1): loaded http://localhost:34830/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34830/tests/kraken/driver.html?testName=imaging-desaturate) 07:52:34 INFO - PROCESS | 11474 | RSS: Main: 222224384 07:52:34 INFO - PROCESS | 11474 | 07:52:37 INFO - PROCESS | 11474 | Cycle 1(1): loaded http://localhost:34830/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34830/tests/kraken/driver.html?testName=json-parse-financial) 07:52:37 INFO - PROCESS | 11474 | RSS: Main: 225632256 07:52:37 INFO - PROCESS | 11474 | 07:52:39 INFO - PROCESS | 11474 | Cycle 1(1): loaded http://localhost:34830/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34830/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:52:40 INFO - PROCESS | 11474 | RSS: Main: 189505536 07:52:40 INFO - PROCESS | 11474 | 07:52:42 INFO - PROCESS | 11474 | Cycle 1(1): loaded http://localhost:34830/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34830/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:52:42 INFO - PROCESS | 11474 | RSS: Main: 197201920 07:52:42 INFO - PROCESS | 11474 | 07:52:44 INFO - PROCESS | 11474 | Cycle 1(1): loaded http://localhost:34830/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34830/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:52:45 INFO - PROCESS | 11474 | RSS: Main: 193794048 07:52:45 INFO - PROCESS | 11474 | 07:52:48 INFO - PROCESS | 11474 | Cycle 1(1): loaded http://localhost:34830/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34830/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:52:48 INFO - PROCESS | 11474 | RSS: Main: 188346368 07:52:48 INFO - PROCESS | 11474 | 07:52:51 INFO - PROCESS | 11474 | Cycle 1(1): loaded http://localhost:34830/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34830/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:52:52 INFO - PROCESS | 11474 | RSS: Main: 191778816 07:52:52 INFO - PROCESS | 11474 | 07:52:54 INFO - PROCESS | 11474 | Cycle 1(1): loaded http://localhost:34830/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34830/tests/kraken/driver.html?testName=ai-astar) 07:52:54 INFO - PROCESS | 11474 | RSS: Main: 242765824 07:52:54 INFO - PROCESS | 11474 | 07:52:54 INFO - PROCESS | 11474 | __start_tp_report 07:52:54 INFO - PROCESS | 11474 | _x_x_mozilla_page_load 07:52:54 INFO - PROCESS | 11474 | _x_x_mozilla_page_load_details 07:52:54 INFO - PROCESS | 11474 | |i|pagename|runs| 07:52:54 INFO - PROCESS | 11474 | |0;ai-astar;105;116;113;113;110;114;113;114;114;113 07:52:54 INFO - PROCESS | 11474 | |1;audio-beat-detection;146;121;125;185;125;123;147;125;159;121 07:52:54 INFO - PROCESS | 11474 | |2;audio-dft;161;160;162;162;160;161;163;161;160;159 07:52:54 INFO - PROCESS | 11474 | |3;audio-fft;75;76;75;117;77;77;75;77;126;75 07:52:54 INFO - PROCESS | 11474 | |4;audio-oscillator;85;86;126;86;87;87;115;86;88;120 07:52:54 INFO - PROCESS | 11474 | |5;imaging-gaussian-blur;117;117;117;116;117;117;118;117;117;117 07:52:54 INFO - PROCESS | 11474 | |6;imaging-darkroom;148;147;148;147;147;146;148;148;146;147 07:52:54 INFO - PROCESS | 11474 | |7;imaging-desaturate;94;96;96;95;95;95;96;95;95;94 07:52:54 INFO - PROCESS | 11474 | |8;json-parse-financial;68;64;66;65;67;69;65;65;67;67 07:52:54 INFO - PROCESS | 11474 | |9;json-stringify-tinderbox;66;66;65;66;66;66;67;66;67;66 07:52:54 INFO - PROCESS | 11474 | |10;stanford-crypto-aes;84;81;82;81;84;81;82;82;81;85 07:52:54 INFO - PROCESS | 11474 | |11;stanford-crypto-ccm;134;130;133;135;130;131;134;141;147;139 07:52:54 INFO - PROCESS | 11474 | |12;stanford-crypto-pbkdf2;174;172;169;171;175;170;170;171;173;169 07:52:54 INFO - PROCESS | 11474 | |13;stanford-crypto-sha256-iterative;68;68;69;67;69;68;67;68;68;68 07:52:54 INFO - PROCESS | 11474 | __end_tp_report 07:52:54 INFO - PROCESS | 11474 | __start_cc_report 07:52:54 INFO - PROCESS | 11474 | _x_x_mozilla_cycle_collect,1915 07:52:54 INFO - PROCESS | 11474 | __end_cc_report 07:52:54 INFO - PROCESS | 11474 | __startTimestamp1471531974506__endTimestamp 07:52:54 INFO - PROCESS | 11474 | 07:52:54 INFO - PROCESS | 11474 | ------- Summary: start ------- 07:52:54 INFO - PROCESS | 11474 | Number of tests: 14 07:52:54 INFO - PROCESS | 11474 | 07:52:54 INFO - PROCESS | 11474 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.50 stddev:3.03 (2.7%) stddev-sans-first:1.58 07:52:54 INFO - PROCESS | 11474 | Values: 105.0 116.0 113.0 113.0 110.0 114.0 113.0 114.0 114.0 113.0 07:52:54 INFO - PROCESS | 11474 | 07:52:54 INFO - PROCESS | 11474 | [#1] audio-beat-detection Cycles:10 Average:137.70 Median:135.50 stddev:21.35 (15.8%) stddev-sans-first:22.44 07:52:54 INFO - PROCESS | 11474 | Values: 146.0 121.0 125.0 185.0 125.0 123.0 147.0 125.0 159.0 121.0 07:52:54 INFO - PROCESS | 11474 | 07:52:54 INFO - PROCESS | 11474 | [#2] audio-dft Cycles:10 Average:160.90 Median:161.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 07:52:54 INFO - PROCESS | 11474 | Values: 161.0 160.0 162.0 162.0 160.0 161.0 163.0 161.0 160.0 159.0 07:52:54 INFO - PROCESS | 11474 | 07:52:54 INFO - PROCESS | 11474 | [#3] audio-fft Cycles:10 Average:85.00 Median:75.50 stddev:19.37 (25.7%) stddev-sans-first:20.21 07:52:54 INFO - PROCESS | 11474 | Values: 75.0 76.0 75.0 117.0 77.0 77.0 75.0 77.0 126.0 75.0 07:52:54 INFO - PROCESS | 11474 | 07:52:54 INFO - PROCESS | 11474 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:86.00 stddev:16.60 (19.3%) stddev-sans-first:17.07 07:52:54 INFO - PROCESS | 11474 | Values: 85.0 86.0 126.0 86.0 87.0 87.0 115.0 86.0 88.0 120.0 07:52:54 INFO - PROCESS | 11474 | 07:52:54 INFO - PROCESS | 11474 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 07:52:54 INFO - PROCESS | 11474 | Values: 117.0 117.0 117.0 116.0 117.0 117.0 118.0 117.0 117.0 117.0 07:52:54 INFO - PROCESS | 11474 | 07:52:54 INFO - PROCESS | 11474 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.50 stddev:0.79 (0.5%) stddev-sans-first:0.78 07:52:54 INFO - PROCESS | 11474 | Values: 148.0 147.0 148.0 147.0 147.0 146.0 148.0 148.0 146.0 147.0 07:52:54 INFO - PROCESS | 11474 | 07:52:54 INFO - PROCESS | 11474 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 07:52:54 INFO - PROCESS | 11474 | Values: 94.0 96.0 96.0 95.0 95.0 95.0 96.0 95.0 95.0 94.0 07:52:54 INFO - PROCESS | 11474 | 07:52:54 INFO - PROCESS | 11474 | [#8] json-parse-financial Cycles:10 Average:66.30 Median:67.00 stddev:1.57 (2.3%) stddev-sans-first:1.54 07:52:54 INFO - PROCESS | 11474 | Values: 68.0 64.0 66.0 65.0 67.0 69.0 65.0 65.0 67.0 67.0 07:52:54 INFO - PROCESS | 11474 | 07:52:54 INFO - PROCESS | 11474 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 07:52:54 INFO - PROCESS | 11474 | Values: 66.0 66.0 65.0 66.0 66.0 66.0 67.0 66.0 67.0 66.0 07:52:54 INFO - PROCESS | 11474 | 07:52:54 INFO - PROCESS | 11474 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.00 stddev:1.49 (1.8%) stddev-sans-first:1.45 07:52:54 INFO - PROCESS | 11474 | Values: 84.0 81.0 82.0 81.0 84.0 81.0 82.0 82.0 81.0 85.0 07:52:54 INFO - PROCESS | 11474 | 07:52:54 INFO - PROCESS | 11474 | [#11] stanford-crypto-ccm Cycles:10 Average:135.40 Median:134.50 stddev:5.44 (4.0%) stddev-sans-first:5.75 07:52:54 INFO - PROCESS | 11474 | Values: 134.0 130.0 133.0 135.0 130.0 131.0 134.0 141.0 147.0 139.0 07:52:54 INFO - PROCESS | 11474 | 07:52:54 INFO - PROCESS | 11474 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:171.50 stddev:2.07 (1.2%) stddev-sans-first:1.96 07:52:54 INFO - PROCESS | 11474 | Values: 174.0 172.0 169.0 171.0 175.0 170.0 170.0 171.0 173.0 169.0 07:52:54 INFO - PROCESS | 11474 | 07:52:54 INFO - PROCESS | 11474 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 07:52:54 INFO - PROCESS | 11474 | Values: 68.0 68.0 69.0 67.0 69.0 68.0 67.0 68.0 68.0 68.0 07:52:54 INFO - PROCESS | 11474 | -------- Summary: end -------- 07:52:54 INFO - PROCESS | 11474 | 07:52:55 INFO - TEST-INFO | 11474: exit 0 07:52:55 INFO - TEST-OK | kraken | took 64029ms 07:52:55 INFO - SUITE-END | took 1184s 07:52:56 INFO - Completed test suite (00:19:44) 07:52:56 INFO - javascript benchmark 07:52:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2597.2338160242725, 2613.1246032579083, 2631.118575277282, 2638.6701662292203, 2639.907603233887, 4584.97707511462, 4665.3235280884255, 4666.813327466902, 4716.646251531136, 4738.620910327174, 4638.304254361839, 4678.672492925497, 4686.203345431276, 4693.50718174591, 4741.407324084489, 4249.6387807036435, 4260.446142001551, 4349.282368409209, 4398.098389830077, 4470.128324976631, 4379.802908869108, 4422.579854913794, 4429.003474218292, 4442.3558584005295, 4456.286994080948, 4222.85220017301, 4227.852025179135, 4244.851430199959, 4271.9359209611885, 4274.422952901349, 4277.97861010696, 4280.700350975433, 4282.678799090049, 4313.676474264411, 4371.4098596689355, 4296.31480324797, 4311.935320970188, 4312.63342615878, 4313.029568347129, 4364.934525982081, 4553.772311384418, 4609.516000819933, 4626.7223966562115, 4712.340272361872, 4762.97596016858, 5017.724025178613, 5028.044671512401, 5035.597152227813, 5058.4435712071645, 5058.898822023539, 5055.620828437882, 5072.6195535335, 5085.389753229599, 5086.974565127188, 5100.923486147711, 4614.792334344963, 4675.392199014106, 4727.24364101749, 4740.786664600101, 4742.549457801503, 5151.2273159026445, 5177.585793136615, 5225.921611175835, 5229.058769421465, 5230.215467679878, 4974.7263900485095, 4977.253411988231, 4980.0, 5020.196768517019, 5023.874403139951, 4873.390826146731, 4996.125678006334, 5014.598832093424, 5024.120778863684, 5039.4708555601865, 5023.070731914608, 5029.547340739351, 5030.044291584587, 5030.346055012825, 5033.79864805411, 4989.800407983713, 5024.296598476216, 5025.522575355335, 5036.043151801146, 5069.163588008011, 4156.9792151039655, 4196.9370459443135, 4200.978995105066, 4251.086016506404, 4336.284513055373, 3683.594804571495, 3731.794751288651, 3752.0, 3771.151490914577, 3818.961810381916, 4319.589638984291, 4320.287152619782, 4321.805518751664, 4329.567043295645, 4375.01562148514, 5024.698518088926, 5033.219850923113, 5033.521815427529, 5044.621653375938, 5057.8735531612, 4126.773027483518, 4247.8088486018205, 4263.976645605095, 4310.482742070909, 4371.912561748811, 4516.8193272268745, 4521.932171017437, 4522.977385113053, 4534.410526631516, 4563.748993805306, 4709.128811169944, 4717.9056418872115, 4726.952730472652, 4732.124556956974, 4756.239001759633, 4910.993246384412, 4994.225894986283, 5043.067032598981, 5044.697318160922, 5129.153689641167, 4747.050589881968, 4765.880852978703, 4766.904661906673, 4781.569658730592, 4821.059893320768, 5009.474005229398, 5010.488106041429, 5013.222950442687, 5018.172001619692, 5061.519155680205, 4889.63327750413, 4944.901101977868, 4962.280469331855, 5013.172826483589, 5049.040682270357, 4886.364772579542, 4888.853334399973, 4890.388701412324, 4895.4859739728245, 4939.185034469272, 4875.8049678012485, 4881.9511804881495, 4888.9755551222015, 4899.0, 4938.08645400602, 4693.0, 4748.0503899220985, 4811.398575178103, 4812.085703716282, 4867.659263851497, 4874.4150701916, 4901.852944411673, 4911.557959783494, 4914.115459217375, 4955.876103097451, 4702.224133018014, 4801.303810947463, 4811.975940120277, 4812.5668689818085, 4860.3681521403405], "value": 4614.396768597666, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [552.4144406928658, 561.4497792163679, 562.8649124210191, 571.0691572736441, 575.4217011903037, 28256.43487130256, 37975.0, 39568.80215598925, 39592.802035989815, 42873.285068597215, 41000.38499422511, 41493.58506414935, 41496.58503414965, 41512.0, 41531.377029344505, 7586.0, 7720.61396930154, 7732.226777322251, 7733.922660773376, 7735.1491335953, 7675.846483070335, 7743.7676869694, 7780.183080776522, 7782.027246594176, 7788.06543214815, 7783.610819459032, 7786.454948153631, 7822.843543129134, 7833.334166595846, 7836.647350869224, 7739.458237923348, 7780.610969451504, 7781.41639377049, 7781.610919454005, 7785.8053548661455, 7598.44231932458, 7662.272084151997, 7662.387009039264, 7664.846703065963, 7702.268284512962, 26472.73527264722, 26649.333766655796, 26688.73311266882, 26699.866500667566, 26712.198634040815, 3007.3083190866005, 3021.1993821637284, 3027.6215473065868, 3034.2884445823815, 3044.147638661156, 26231.0, 28689.159153909422, 29176.0, 29239.70760292391, 29966.101016969307, 3322.9169270768425, 3397.643247459006, 3407.8296085195643, 3434.9484757728405, 3459.636738142484, 258972.705136475, 259746.0, 259829.0, 260441.9999999981, 260534.0, 51472.74263628658, 51748.0, 51839.22241166385, 51880.0, 51902.22146667803, 32425.837870810967, 33335.333293334, 33576.49635255473, 53051.0, 53216.0, 13676.632336766244, 13893.374798134108, 13943.790843137362, 14016.85983140176, 14134.717305653829, 10257.794844103077, 10350.0, 10375.481225938824, 10389.480525973671, 10397.428141452292, 17982.460526184237, 17985.55036124081, 18026.909865450853, 18029.926558445684, 18070.0, 6772.424343930723, 6793.864122717518, 6830.496415084021, 6904.240533541307, 7025.543339682904, 752.5860776572863, 817.8323443694028, 956.6269155029544, 968.1577027985697, 971.718201721507, 27296.863515682293, 27313.371228509935, 27859.796123445656, 28087.0, 28492.71507284942, 834.6411043251338, 891.6166048599035, 913.1735779119907, 922.8754118193958, 946.9384490008127, 13405.932970335087, 14096.295185240697, 14115.505957291445, 14279.92860035714, 14494.202818844853, 379055.0, 383478.0, 383494.0, 383686.0, 384225.0, 48349.0, 48670.75664621654, 49048.0, 49061.26408103881, 49074.75462622664, 1038.745507350704, 1106.905912997372, 1115.7489564847845, 1174.1956759619688, 1194.211820198682, 25433.491330173663, 29363.41273174482, 29451.41097178087, 29803.85098074496, 29898.85050574733, 40213.195736084526, 41183.0, 41198.38202427026, 41241.0, 41259.38110928398, 236036.0, 236731.0, 236731.0, 237142.0, 237213.0, 21945.451363716034, 24305.75694243035, 25224.495510090062, 25520.361990950376, 25578.74421255838, 38525.42211866768, 38903.80548097355, 41992.370114447695, 42020.0, 42065.57934420617, 35191.47212791861, 35348.646513534535, 35642.821785890905, 35897.820510897276, 36108.0, 34475.4828677565, 35089.298214036084, 35421.0, 35730.0, 36152.0, 26886.462270754084, 34609.826950865085, 35152.0, 35210.647893520734, 35937.82031089828, 30905.381892361576, 31914.36171276608, 32629.18427039343, 33417.0, 33729.66270337364, 25246.495070098863, 25706.614400784376, 25742.742572574036, 25750.613740794277, 25912.61131083073], "value": 16784.48020776097, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.8739864342919, 361.784738080842, 363.63454727998356, 365.77504834526763, 380.39327272999554, 12566.371681415927, 13472.730545389086, 14013.719725605495, 16844.24200910959, 16847.74728379075, 15126.168060756654, 15277.61805954849, 15832.366705331802, 15917.681646367066, 15995.360185592563, 4567.634589232862, 4691.437027556698, 4705.505921878204, 4706.176419126657, 4713.245880659095, 3433.3305005523935, 5617.354004289518, 5823.126531020339, 5883.117532370157, 5959.374265702104, 5678.233438485813, 5912.7930522431725, 5922.200502932092, 5925.140854576105, 5927.851803704921, 5809.3609702932645, 5839.065749480105, 5840.211571437865, 5853.678047707374, 5869.735861886183, 5128.512791284822, 5200.869978250536, 5211.843644690665, 5222.164453687392, 5277.3139491866195, 12376.504939802397, 12448.688782780413, 18571.62856742871, 20880.895595521924, 21033.579328413347, 1745.3106023120922, 1833.1292635997927, 1884.148704647764, 2193.5503221839485, 2286.4969706664506, 8591.484510929364, 9227.630894764201, 9395.201407880339, 9542.618295268181, 9642.662506812228, 1640.8441198086164, 1714.3999600139975, 1722.1991773825232, 1738.226489212301, 1793.4619614115713, 66346.66826665885, 66777.66611166912, 67868.6606566964, 69022.0, 72360.6381968092, 9839.704808855746, 10012.299139060196, 10107.595696172071, 10178.541965611565, 10402.27184097121, 13735.862641373658, 13746.65633359174, 13849.16904985704, 13898.444062237397, 13915.30423478822, 6995.545289556163, 7161.176464706626, 7200.747973820891, 7272.05463289769, 7325.6337183141695, 6587.473002159816, 6588.73645054202, 6721.092652491949, 6768.323167683291, 6856.0, 4302.118065796504, 4314.61168494837, 4333.068390296102, 4341.739495630272, 4449.0, 1790.7851057872879, 1813.5322004157476, 1894.658961386936, 1923.249932526316, 1923.7210604462275, 818.1532114261711, 854.2311919272704, 867.1761826265074, 877.7059685005466, 920.0845159066771, 16434.17829108564, 16567.088810115558, 16701.49895503137, 17354.39259625907, 17967.371142009968, 841.7011960753966, 852.3436953545735, 868.774118729135, 871.1941454154882, 920.7744102694749, 9229.584668689926, 10031.29780915329, 10109.443980581138, 10212.744681382876, 10228.948855255825, 398365.0, 401792.0, 404924.0, 413258.0, 414097.0, 50061.0, 65990.0, 77495.61252193703, 81200.59399702963, 83845.58077209575, 837.698428565728, 846.3821410370341, 847.1486156412766, 849.1720572441819, 856.0198572634423, 15688.137152456267, 15740.134292614017, 15937.601559961095, 16009.279582418587, 16282.0, 36645.63354366422, 37749.54627949175, 38739.41890871583, 39033.2193356137, 39413.0, 48625.0, 51428.48571514237, 51728.741356294486, 52027.0, 53797.0, 7578.09062912454, 7634.549435607217, 7680.193579674277, 7844.4901081429525, 8216.34269258446, 9824.852627210455, 10913.508892100033, 11038.779224415628, 11902.464389102339, 12236.816447753114, 9863.21094312439, 9883.55524001436, 10006.249531285037, 10227.130693891102, 10593.629222977159, 10144.188464922641, 10198.745031374276, 10288.331258468175, 10522.053015228666, 10527.368357898551, 9799.51002449889, 9832.754181145528, 10043.849342259726, 10194.286399951932, 10507.632232871812, 7732.536047837148, 7770.300672939463, 7842.686292548462, 7855.293023627901, 8030.277275045274, 8882.245009174292, 9765.365251258645, 10064.245181611263, 10082.949585252027, 10314.845277320996], "value": 8113.218535317957, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1217.957371491998, 1372.0464277327258, 1401.0052862467649, 1468.5224114054577, 1664.4257731082773, 6486.091947127406, 7426.888596671048, 7752.186020467854, 7765.572893490856, 8000.759977200679, 7838.529688218711, 7900.6444709988045, 7910.327622152109, 7917.287444130027, 7922.128565857765, 2167.111484291441, 2186.2020362567628, 2190.6494960806276, 2192.7039849620255, 2193.747719012318, 2147.334326358826, 2186.7485239197536, 2202.691623172749, 2204.1403852497538, 2205.2612374854443, 2151.268568686646, 2154.472154322193, 2158.3740715192575, 2164.5346250556127, 2204.360735386736, 2114.598226336991, 2119.459537817854, 2122.066290832029, 2123.076461739133, 2129.7124888140133, 2058.835293176557, 2136.861104028233, 2136.8611040282485, 2139.6255655260425, 2146.8389870759756, 7607.277308655669, 7664.540127592307, 7756.961215193945, 7763.068431788165, 7850.057993040871, 4306.978465107686, 4476.55234476553, 4488.079943611552, 4493.146302202571, 4493.68544201906, 2761.144045345949, 2913.9271518212004, 2966.258435391152, 2968.495355789499, 2975.3156773942114, 900.7793090692757, 907.3240435875315, 928.0580211085753, 928.0580211085753, 928.071928071928, 10360.171186305077, 10430.791384172275, 10461.738456538571, 10472.057514823626, 10477.161827053817, 3928.7642741435607, 4064.248114098901, 4216.430781844411, 4223.408722778813, 4236.131593023423, 8338.749837504885, 8342.958285208657, 8351.415400921998, 8353.20644538768, 8360.958195208985, 4441.111777644484, 4441.578050085237, 4445.088756804847, 4446.911061778746, 4448.110377924363, 3567.7324200685052, 3991.900202494961, 4111.6916231282175, 4139.068709540389, 4141.8964525886495, 3436.570428696413, 3465.9653403466145, 3578.427451607782, 3581.94627080594, 3590.9281814363567, 1047.554789214596, 1061.9415932123807, 1071.3357718214756, 1074.6399956014666, 1081.8755843078147, 756.1984296645574, 822.9341652667772, 839.0812060793421, 852.6845067325005, 862.3790870573177, 5379.220013098157, 5530.889382212414, 5576.302962129734, 5638.0, 5756.856078598069, 795.9044914610283, 818.2758258940761, 835.5655059369094, 861.2205953611866, 895.8700988356652, 3746.925061498755, 3869.4776205212497, 3873.12854607711, 3930.744501607386, 3934.3672375963656, 9583.0, 9723.708288751348, 9853.0, 9968.152707019985, 9985.350952188084, 9645.0, 9651.276154288316, 9653.662121825842, 9678.322517423712, 9698.51507424626, 7179.066721326194, 7316.743913963092, 7319.15829679583, 7322.340989310987, 7334.9266507335315, 5132.30713853625, 5462.754176062007, 5465.480779325958, 5584.972075139598, 5735.369109398046, 8794.252488538546, 8882.378233523592, 8944.955275223581, 9062.365634405529, 9107.863382049141, 9192.49441280736, 9294.117058879396, 9294.302927280345, 9295.76760580991, 9306.06939306064, 5808.535317174531, 6190.442860142609, 6390.265119511316, 6545.247296560766, 6553.705083271169, 7129.928700712927, 7375.336219740249, 7381.667824947997, 7398.667059982421, 7406.296401841816, 6597.934020659924, 6669.566043300713, 6670.599764014175, 6821.863562728817, 6861.519693621399, 6379.362063793769, 6381.87236255263, 6432.903506447314, 6455.354464553507, 6461.06314584392, 6307.400796924285, 6390.105385245976, 6394.0, 6396.712147953446, 6407.3592640737415, 4616.353710480468, 4657.813687452464, 4752.477227505041, 4764.595009424238, 4779.402574678165, 4577.610903073276, 4631.8378856739855, 4643.930341044955, 4695.741734204515, 4945.77744001528], "value": 4102.079893119871, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.7935607006886, 296.1367613406919, 298.96412430508343, 300.81199250468455, 301.9924501887454, 4827.806887724487, 4880.755962201893, 4889.291052797343, 4889.853304400869, 4892.290617860417, 4553.7704819698665, 4647.302904564317, 4689.835855745049, 4720.221163508026, 4832.4684284728655, 3815.0433414104014, 3815.389537673973, 3816.3893776995687, 3821.5414150301863, 3823.5985221551755, 3811.7331786774935, 3824.9426258606145, 3829.6553310202216, 3832.712546559005, 3857.749246298996, 3602.5676918769655, 3610.6569875861883, 3703.0558956547757, 3784.8107594620296, 3800.163963927945, 3764.153065560227, 3767.5699174032598, 3767.642074002979, 3770.1894092770185, 3770.679492243149, 3332.9834400507834, 3347.916302092443, 3350.2294472271515, 3350.547676063725, 3355.724824566649, 4466.240739074366, 4710.317004034396, 4710.69380490267, 4720.905581888377, 4763.857084287477, 4302.978485107586, 4332.1119170569955, 4335.6965012449145, 4339.349097635349, 4352.260115780293, 5074.594032477393, 5086.516780905808, 5095.388553373619, 5096.898062038738, 5114.923276150861, 3699.72252081095, 3702.9259414811554, 3706.5737440194184, 3708.796016219107, 3715.405535114369, 5142.640015198937, 5272.340957380327, 5283.365996080495, 5283.682979021271, 5318.282031925679, 3708.9814550927613, 3713.1459764254373, 3717.4052151656147, 3728.813559322023, 3733.7386382953478, 3802.1255111324, 3806.809659517013, 3807.8667246646787, 3826.712996525216, 3828.1386687994977, 4236.428082208924, 4253.820551865805, 4294.9785251073545, 4336.783160841946, 4348.434703488526, 5077.543021128116, 5082.67850358902, 5090.949090509048, 5095.834270435124, 5098.821541246039, 1265.3862876504888, 1337.1976813911576, 1341.4298922957703, 1349.865013498662, 1353.8916886649044, 896.1755185229605, 908.9590968406437, 926.8980412154658, 933.696548621687, 934.8784657994418, 4418.977905110518, 4431.246688063037, 4438.511763706054, 4439.755813430293, 4445.644078556007, 5146.716930568779, 5159.0, 5161.793528258828, 5194.7272918135295, 5206.214675148777, 4341.9565804341555, 4412.646988240933, 4418.248897687401, 4426.84506042287, 4466.4640243171025, 2732.4808286425514, 2744.533429317021, 2746.931326716808, 2747.3406382468465, 2750.3949131191107, 4816.434658735925, 4850.272459131088, 4864.927026094611, 4868.610511159099, 4873.731944743073, 5037.5214354636255, 5196.350456192976, 5255.605829562798, 5272.789088436496, 5292.761825717852, 4824.42992185787, 4837.105135549864, 4838.274258861128, 4851.805927762991, 4857.198562237262, 5130.640855140105, 5140.974295128501, 5142.434332223527, 5145.871353216199, 5165.741712914264, 4886.921239619017, 5006.924896126634, 5017.949820501748, 5050.520200580939, 5062.493750624908, 4837.637177211794, 4842.854714358575, 4843.539863712942, 4844.806207751651, 4846.224604063333, 3779.7732136071922, 3791.1659434924272, 3806.904827379227, 3808.4477750725437, 3812.941011853568, 4889.779959901742, 5091.261767043832, 5104.259882317117, 5146.716930568855, 5157.174852023658, 4949.020391843292, 4949.208126699711, 4969.887797685897, 4981.975090124526, 4999.575121090472, 4994.400671919393, 5001.699898006132, 5002.299678045004, 5019.347484826949, 5029.597632189343, 4688.789004494738, 4768.713877167381, 4964.765855365028, 4979.203327467588, 5030.698158110525, 4958.628102892226, 5075.87310317245, 5107.471801458302, 5108.770105345343, 5125.4362020177, 4976.30331753562, 4976.8755781105765, 4987.750612469435, 4988.226824842155, 4992.825251116194], "value": 3819.057326082824, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [606.4462251207921, 640.094266612743, 659.4394764450218, 703.2018658822235, 718.9568625882446, 11659.70850728731, 12722.0, 12726.300053497054, 12773.872261277384, 12784.936075319622, 12256.26462412256, 12353.0, 12353.567625133122, 12363.134580579363, 12371.566995155172, 615.6952308607223, 737.8561180569791, 745.899303594016, 767.3630886364305, 769.4613770360742, 777.5567926282022, 778.3850757901251, 780.4263866058471, 780.5238804329383, 781.0237203495631, 827.735124760077, 830.4187069051658, 830.4394533689765, 830.6096134816627, 830.8421399934024, 650.5933791380387, 785.1089013969157, 805.3315747929205, 810.9959450202771, 816.8978877640295, 595.2648479128273, 595.4224402329734, 595.499780184647, 598.4673640459994, 599.5084031094505, 11884.584039558575, 11945.283283003047, 11958.0, 11987.340696261703, 12012.63962081139, 11350.772984540345, 11727.472263748152, 12272.447739851728, 12306.200096993667, 12712.618621441372, 10643.84034239487, 10657.147428205724, 10678.51946662402, 10741.731456713567, 10856.511456984455, 3994.380870964976, 4044.3933409988445, 4048.9392659110135, 4054.9594504054876, 4209.431726716915, 60899.69550152265, 61934.0, 63457.68271158661, 64588.3541164587, 65266.3473365265, 9679.758006049906, 9742.707718768448, 9822.26333025026, 9974.601015959426, 10013.29906906524, 15250.161241131622, 15680.137592432526, 15706.607334816721, 15894.52316430509, 19771.209151633775, 6482.675866206765, 6494.935050649433, 6666.799996000128, 6710.865782684319, 6950.478714096463, 3591.964080359163, 3595.1191957970464, 3649.4708267301094, 3734.7198960078103, 3737.417378047262, 2965.644122705246, 3094.5977022987317, 3096.5664806927048, 3099.02380750063, 3099.7365223955767, 490.8183971930337, 511.0953612106625, 512.7000704587858, 519.8856251624636, 529.684837521674, 468.7281376801447, 529.9136769622336, 538.978440862369, 561.7303694226713, 581.7818318130701, 7849.803754906173, 8125.431219814556, 8219.0, 8358.45670031446, 8541.530215838064, 506.96831946987703, 542.956563474921, 544.2081771023152, 598.4643743849231, 604.9546284028628, 3525.136341596325, 3766.8116594170183, 3911.9608803911597, 3969.146633473817, 4082.652974497201, 103703.4814825921, 106596.46701766597, 110370.44814775875, 110818.0, 112505.43747281375, 51417.485825142016, 66080.0, 77811.83282250771, 84694.99999999876, 85565.0, 49831.750841245565, 81645.59177204076, 82295.5885220582, 82941.92645183919, 84784.57607711921, 7653.770386888402, 7836.804079898048, 8380.748577542683, 8481.787955301166, 8543.829123417372, 29575.704242957294, 46199.45310117639, 46998.0, 47021.0, 47935.0, 61111.69444152751, 61876.69061654663, 62055.689721551105, 63285.683571581845, 64289.67855160694, 11658.76682466363, 11803.114766392384, 11813.232139910879, 12130.393480326125, 12569.93715031419, 12467.875321247035, 12483.500659973499, 12747.0, 13008.463349646729, 13593.388297526833, 11312.886871131182, 11510.251833630788, 11849.111316651113, 11980.460879260629, 12364.62906112818, 10959.397233151934, 11284.266522676, 11431.885681143414, 12059.75880482403, 12419.0, 11193.832092518782, 11485.081193504666, 11932.582359617372, 12264.32546209967, 12271.263724176579, 9711.9028809711, 9964.153046991087, 10063.798724025624, 10183.934738300373, 10325.432101234204, 8484.236418722097, 9050.230730387992, 9145.3598248122, 9346.953265233902, 9421.905780942103], "value": 6480.045980188154, "unit": "score"}], "name": "dromaeo_css", "value": 6321.21233911655, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 116.0, 113.0, 113.0, 110.0, 114.0, 113.0, 114.0, 114.0, 113.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 121.0, 125.0, 185.0, 125.0, 123.0, 147.0, 125.0, 159.0, 121.0], "value": 137.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 162.0, 162.0, 160.0, 161.0, 163.0, 161.0, 160.0, 159.0], "value": 160.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 117.0, 77.0, 77.0, 75.0, 77.0, 126.0, 75.0], "value": 85.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 126.0, 86.0, 87.0, 87.0, 115.0, 86.0, 88.0, 120.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 148.0, 147.0, 147.0, 146.0, 148.0, 148.0, 146.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 64.0, 66.0, 65.0, 67.0, 69.0, 65.0, 65.0, 67.0, 67.0], "value": 66.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 66.0, 66.0, 66.0, 67.0, 66.0, 67.0, 66.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 82.0, 81.0, 84.0, 81.0, 82.0, 82.0, 81.0, 85.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 130.0, 133.0, 135.0, 130.0, 131.0, 134.0, 141.0, 147.0, 139.0], "value": 135.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 172.0, 169.0, 171.0, 175.0, 170.0, 170.0, 171.0, 173.0, 169.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 69.0, 67.0, 69.0, 68.0, 67.0, 68.0, 68.0, 68.0], "value": 68.0, "unit": "score"}], "name": "kraken", "value": 1541.5000000000002, "alertThreshold": 2.0}]} 07:52:56 INFO - Return code: 0 07:52:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:52:56 INFO - # TBPL SUCCESS # 07:52:56 INFO - Running post-action listener: _resource_record_post_action 07:52:56 INFO - [mozharness: 2016-08-18 14:52:56.298114Z] Finished run-tests step (success) 07:52:56 INFO - Running post-run listener: _resource_record_post_run 07:52:56 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 408231936; Read time: 12; Write time: 363372 07:52:56 INFO - TinderboxPrint: CPU usage
13.0% 07:52:56 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 07:52:56 INFO - TinderboxPrint: I/O write bytes / time
408,231,936 / 363,372 07:52:56 INFO - TinderboxPrint: CPU idle
8,341.0 (87.0%) 07:52:56 INFO - TinderboxPrint: CPU user
1,199.4 (12.5%) 07:52:56 INFO - TinderboxPrint: Swap in / out
0 / 0 07:52:56 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 113733632; Read time: 0; Write time: 136848 07:52:56 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 292098048; Read time: 0; Write time: 226344 07:52:56 INFO - Running post-run listener: _upload_blobber_files 07:52:56 INFO - Blob upload gear active. 07:52:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:52:56 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 07:52:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:52:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:52:57 INFO - (blobuploader) - INFO - Open directory for files ... 07:52:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:52:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:52:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:53:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:53:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:53:01 INFO - (blobuploader) - INFO - Done attempting. 07:53:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:53:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:53:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:53:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:53:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:53:02 INFO - (blobuploader) - INFO - Done attempting. 07:53:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:53:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:53:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:53:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:53:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:53:03 INFO - (blobuploader) - INFO - Done attempting. 07:53:03 INFO - (blobuploader) - INFO - Iteration through files over. 07:53:03 INFO - Return code: 0 07:53:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:53:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:53:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/443acaa85b4c4c7819b9f1148ba7fe2f789c829989f88bc2218aca503bf5dc43d7a5b14d7bf042d91976c67975e730f8042867e8daaa168e5bb160962dc6ff0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/88098c6940869db475959eb1352b3313c7ab74b35f1d569744a113ba9ebdb6c837d77deca3ce4da19435f607d72d07be5418b294a065bd2c263ff94996629ebf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b2eaddd901a657b2bbef3cc352fe6fc658ba08abf1b839582616f407d90f6a9ac31fbd5ba21be217f72e63943835b5e9922051f2b13891eae3b16be7d14dc33c"} 07:53:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:53:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:53:03 INFO - Contents: 07:53:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/443acaa85b4c4c7819b9f1148ba7fe2f789c829989f88bc2218aca503bf5dc43d7a5b14d7bf042d91976c67975e730f8042867e8daaa168e5bb160962dc6ff0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/88098c6940869db475959eb1352b3313c7ab74b35f1d569744a113ba9ebdb6c837d77deca3ce4da19435f607d72d07be5418b294a065bd2c263ff94996629ebf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b2eaddd901a657b2bbef3cc352fe6fc658ba08abf1b839582616f407d90f6a9ac31fbd5ba21be217f72e63943835b5e9922051f2b13891eae3b16be7d14dc33c"} 07:53:03 INFO - Running post-run listener: copy_logs_to_upload_dir 07:53:03 INFO - Copying logs to upload dir... 07:53:03 INFO - mkdir: /builds/slave/test/build/upload/logs 07:53:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.902808 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-08-18 07:53:03.603594) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 07:53:03.607062) ========= 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=d2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647 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/443acaa85b4c4c7819b9f1148ba7fe2f789c829989f88bc2218aca503bf5dc43d7a5b14d7bf042d91976c67975e730f8042867e8daaa168e5bb160962dc6ff0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/88098c6940869db475959eb1352b3313c7ab74b35f1d569744a113ba9ebdb6c837d77deca3ce4da19435f607d72d07be5418b294a065bd2c263ff94996629ebf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b2eaddd901a657b2bbef3cc352fe6fc658ba08abf1b839582616f407d90f6a9ac31fbd5ba21be217f72e63943835b5e9922051f2b13891eae3b16be7d14dc33c"} build_url:https://queue.taskcluster.net/v1/task/NoVgWCbsTP-c-cfWDxoJow/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011252 build_url: 'https://queue.taskcluster.net/v1/task/NoVgWCbsTP-c-cfWDxoJow/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/443acaa85b4c4c7819b9f1148ba7fe2f789c829989f88bc2218aca503bf5dc43d7a5b14d7bf042d91976c67975e730f8042867e8daaa168e5bb160962dc6ff0d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/88098c6940869db475959eb1352b3313c7ab74b35f1d569744a113ba9ebdb6c837d77deca3ce4da19435f607d72d07be5418b294a065bd2c263ff94996629ebf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/b2eaddd901a657b2bbef3cc352fe6fc658ba08abf1b839582616f407d90f6a9ac31fbd5ba21be217f72e63943835b5e9922051f2b13891eae3b16be7d14dc33c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-18 07:53:03.632026) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 07:53:03.632347) ========= 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=d2a8c569965ab8367867b893000001a1-1471530735.478328-1918401647 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-18 07:53:03.715502) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 07:53:03.715831) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-18 07:53:03.716111) ========= ========= Total master_lag: 0.16 =========