builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-065 starttime: 1487351099.99 results: success (0) revision: 2af97db52557c07ca1dc692bb5406ccafbb704e5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-17 09:04:59.993084) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-17 09:04:59.993489) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2017-02-17 09:04:59.993768) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 1 secs) (at 2017-02-17 09:05:01.254021) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 09:05:01.254391) ========= 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=523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-17 09:05:02-- 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: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 45.9M=0s 2017-02-17 09:05:02 (45.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.089970 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 09:05:01.415496) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 09:05:01.415884) ========= 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=523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017087 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 09:05:01.444754) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-17 09:05:01.445111) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2af97db52557c07ca1dc692bb5406ccafbb704e5 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2af97db52557c07ca1dc692bb5406ccafbb704e5 --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=523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-17 09:05:02,249 truncating revision to first 12 chars 2017-02-17 09:05:02,249 Setting DEBUG logging. 2017-02-17 09:05:02,249 attempt 1/10 2017-02-17 09:05:02,250 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2af97db52557?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-17 09:05:03,521 unpacking tar archive at: mozilla-aurora-2af97db52557/testing/mozharness/ program finished with exit code 0 elapsedTime=1.580610 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-17 09:05:03.043667) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-17 09:05:03.044176) ========= script_repo_revision: 2af97db52557c07ca1dc692bb5406ccafbb704e5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-17 09:05:03.044821) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-17 09:05:03.045288) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-17 09:05:03.056471) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-17 09:05:03.057094) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-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', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-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=523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:05:03 INFO - MultiFileLogger online at 20170217 09:05:03 in /builds/slave/test 09:05:03 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 09:05:03 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:05:03 INFO - {'append_to_log': False, 09:05:03 INFO - 'base_work_dir': '/builds/slave/test', 09:05:03 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 09:05:03 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:05:03 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 09:05:03 INFO - 'buildbot_json_path': 'buildprops.json', 09:05:03 INFO - 'config_files': ('talos/linux_config.py',), 09:05:03 INFO - 'default_actions': ('clobber', 09:05:03 INFO - 'read-buildbot-config', 09:05:03 INFO - 'download-and-extract', 09:05:03 INFO - 'populate-webroot', 09:05:03 INFO - 'create-virtualenv', 09:05:03 INFO - 'install', 09:05:03 INFO - 'run-tests'), 09:05:03 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:05:03 INFO - 'download_minidump_stackwalk': True, 09:05:03 INFO - 'download_symbols': 'ondemand', 09:05:03 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:05:03 INFO - 'tooltool.py': '/tools/tooltool.py', 09:05:03 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:05:03 INFO - '/tools/misc-python/virtualenv.py')}, 09:05:03 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:05:03 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:05:03 INFO - 'installer_path': 'installer.exe', 09:05:03 INFO - 'log_level': 'info', 09:05:03 INFO - 'log_name': 'talos', 09:05:03 INFO - 'log_to_console': True, 09:05:03 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:05:03 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:05:03 INFO - 'opt_config_files': (), 09:05:03 INFO - 'pip_index': False, 09:05:03 INFO - 'sps_profile': False, 09:05:03 INFO - 'sps_profile_interval': 0, 09:05:03 INFO - 'suite': 'dromaeojs', 09:05:03 INFO - 'system_bits': '32', 09:05:03 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:05:03 INFO - 'title': 'talos-linux64-ix-065', 09:05:03 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:05:03 INFO - 'use_talos_json': True, 09:05:03 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:05:03 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:05:03 INFO - 'work_dir': 'build'} 09:05:03 INFO - [mozharness: 2017-02-17 17:05:03.961061Z] Running clobber step. 09:05:03 INFO - Running pre-action listener: _resource_record_pre_action 09:05:03 INFO - Running main action method: clobber 09:05:03 INFO - rmtree: /builds/slave/test/build 09:05:03 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:05:04 INFO - Running post-action listener: _resource_record_post_action 09:05:04 INFO - [mozharness: 2017-02-17 17:05:04.884007Z] Finished clobber step (success) 09:05:04 INFO - [mozharness: 2017-02-17 17:05:04.884107Z] Running read-buildbot-config step. 09:05:04 INFO - Running pre-action listener: _resource_record_pre_action 09:05:04 INFO - Running main action method: read_buildbot_config 09:05:04 INFO - Using buildbot properties: 09:05:04 INFO - { 09:05:04 INFO - "project": "", 09:05:04 INFO - "product": "firefox", 09:05:04 INFO - "who": "cbook@mozilla.com", 09:05:04 INFO - "installer_path": "public/build/target.tar.bz2", 09:05:04 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 09:05:04 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 09:05:04 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs", 09:05:04 INFO - "stage_platform": "linux64", 09:05:04 INFO - "basedir": "/builds/slave/test", 09:05:04 INFO - "buildnumber": 34, 09:05:04 INFO - "platform": "ubuntu64_hw", 09:05:04 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:05:04 INFO - "slavebuilddir": "test", 09:05:04 INFO - "taskId": "bkqoziYrQ4CCwbBKenW1fw", 09:05:04 INFO - "branch": "mozilla-aurora", 09:05:04 INFO - "script_repo_revision": "production", 09:05:04 INFO - "revision": "2af97db52557c07ca1dc692bb5406ccafbb704e5", 09:05:04 INFO - "slavename": "talos-linux64-ix-065", 09:05:04 INFO - "repo_path": "releases/mozilla-aurora" 09:05:04 INFO - } 09:05:04 INFO - Finding installer, test and symbols from parent task. 09:05:04 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bkqoziYrQ4CCwbBKenW1fw'}, attempt #1 09:05:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bkqoziYrQ4CCwbBKenW1fw'}, attempt #1 09:05:05 INFO - Task dependencies: fRCJqJSeSlOS11TkaBvsyw 09:05:05 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw'}, attempt #1 09:05:06 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw/artifacts/public/build/target.tar.bz2 09:05:06 INFO - Set test_url: https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw/artifacts/public/build/test_packages.json 09:05:06 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw/artifacts/public/build/target.crashreporter-symbols.zip 09:05:06 INFO - Running post-action listener: _resource_record_post_action 09:05:06 INFO - [mozharness: 2017-02-17 17:05:06.282474Z] Finished read-buildbot-config step (success) 09:05:06 INFO - [mozharness: 2017-02-17 17:05:06.282727Z] Running download-and-extract step. 09:05:06 INFO - Running pre-action listener: _resource_record_pre_action 09:05:06 INFO - Running main action method: download_and_extract 09:05:06 INFO - mkdir: /builds/slave/test/build/tests 09:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:06 INFO - trying https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw/artifacts/public/build/target.test_packages.json 09:05:06 INFO - Downloading https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 09:05:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 09:05:06 INFO - Downloaded 896 bytes. 09:05:06 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 09:05:06 INFO - Using the following test package requirements: 09:05:06 INFO - {u'common': [u'target.common.tests.zip'], 09:05:06 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 09:05:06 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 09:05:06 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 09:05:06 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 09:05:06 INFO - u'mozbase': [u'target.common.tests.zip'], 09:05:06 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 09:05:06 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 09:05:06 INFO - u'web-platform': [u'target.common.tests.zip', 09:05:06 INFO - u'target.web-platform.tests.zip'], 09:05:06 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 09:05:06 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 09:05:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw/artifacts/public/build/target.common.tests.zip 09:05:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:05:06 INFO - Fetch https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw/artifacts/public/build/target.common.tests.zip into memory 09:05:07 INFO - Expected file size: 21859077 09:05:07 INFO - Obtained file size: 21859077 09:05:11 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 09:05:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw/artifacts/public/build/target.common.tests.zip 09:05:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw/artifacts/public/build/target.common.tests.zip'}, attempt #1 09:05:11 INFO - Fetch https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw/artifacts/public/build/target.common.tests.zip into memory 09:05:12 INFO - Expected file size: 21859077 09:05:12 INFO - Obtained file size: 21859077 09:05:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw/artifacts/public/build/target.talos.tests.zip 09:05:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 09:05:17 INFO - Fetch https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw/artifacts/public/build/target.talos.tests.zip into memory 09:05:17 INFO - Expected file size: 14403485 09:05:17 INFO - Obtained file size: 14403485 09:05: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')]} 09:05:18 INFO - trying https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw/artifacts/public/build/target.tar.bz2 09:05:18 INFO - Downloading https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 09:05:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 09:05:19 INFO - Downloaded 66097734 bytes. 09:05:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw/artifacts/public/build/target.tar.bz2 09:05:19 INFO - mkdir: /builds/slave/test/properties 09:05:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:05:19 INFO - Writing to file /builds/slave/test/properties/build_url 09:05:19 INFO - Contents: 09:05:19 INFO - build_url:https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw/artifacts/public/build/target.tar.bz2 09:05:19 INFO - Running post-action listener: _resource_record_post_action 09:05:19 INFO - Running post-action listener: set_extra_try_arguments 09:05:19 INFO - [mozharness: 2017-02-17 17:05:19.344765Z] Finished download-and-extract step (success) 09:05:19 INFO - [mozharness: 2017-02-17 17:05:19.344862Z] Running populate-webroot step. 09:05:19 INFO - Running pre-action listener: _resource_record_pre_action 09:05:19 INFO - Running main action method: populate_webroot 09:05:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:05:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:05:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:05:19 INFO - '--tppagecycles', 09:05:19 INFO - '7'], 09:05:19 INFO - 'tests': ['tsvgm']}}, 09:05:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:05:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:05:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:05:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:05:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:05:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:05:19 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:05:19 INFO - 'talos_options': ['--disable-e10s'], 09:05:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:05:19 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:05:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:05:19 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:05:19 INFO - 'talos_options': ['--disable-e10s'], 09:05:19 INFO - 'tests': ['damp', 'tps']}, 09:05:19 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:05:19 INFO - 'tests': ['damp', 'tps']}, 09:05:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:05:19 INFO - 'tests': ['dromaeo_dom']}, 09:05:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:05:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:05:19 INFO - 'tests': ['basic_compositor_video']}, 09:05:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:05:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:05:19 INFO - 'tests': ['a11yr', 09:05:19 INFO - 'ts_paint', 09:05:19 INFO - 'tpaint', 09:05:19 INFO - 'sessionrestore', 09:05:19 INFO - 'sessionrestore_no_auto_restore', 09:05:19 INFO - 'tabpaint']}, 09:05:19 INFO - 'other-e10s': {'tests': ['a11yr', 09:05:19 INFO - 'ts_paint', 09:05:19 INFO - 'tpaint', 09:05:19 INFO - 'sessionrestore', 09:05:19 INFO - 'sessionrestore_no_auto_restore', 09:05:19 INFO - 'tabpaint']}, 09:05:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:05:19 INFO - 'ts_paint', 09:05:19 INFO - 'tpaint', 09:05:19 INFO - 'sessionrestore', 09:05:19 INFO - 'sessionrestore_no_auto_restore', 09:05:19 INFO - 'tabpaint']}, 09:05:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:05:19 INFO - 'ts_paint', 09:05:19 INFO - 'tpaint', 09:05:19 INFO - 'sessionrestore', 09:05:19 INFO - 'sessionrestore_no_auto_restore', 09:05:19 INFO - 'tabpaint']}, 09:05:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:05:19 INFO - 'tests': ['a11yr', 09:05:19 INFO - 'ts_paint', 09:05:19 INFO - 'tpaint', 09:05:19 INFO - 'sessionrestore', 09:05:19 INFO - 'sessionrestore_no_auto_restore', 09:05:19 INFO - 'tabpaint']}, 09:05:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:05:19 INFO - 'tests': ['a11yr', 09:05:19 INFO - 'ts_paint', 09:05:19 INFO - 'tpaint', 09:05:19 INFO - 'sessionrestore', 09:05:19 INFO - 'sessionrestore_no_auto_restore', 09:05:19 INFO - 'tabpaint']}, 09:05:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:05:19 INFO - 'tests': ['tsvgx', 09:05:19 INFO - 'tsvgr_opacity', 09:05:19 INFO - 'tart', 09:05:19 INFO - 'tscrollx', 09:05:19 INFO - 'cart', 09:05:19 INFO - 'tsvg_static']}, 09:05:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:05:19 INFO - 'tsvgr_opacity', 09:05:19 INFO - 'tart', 09:05:19 INFO - 'tscrollx', 09:05:19 INFO - 'cart', 09:05:19 INFO - 'tsvg_static']}, 09:05:19 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:05:19 INFO - 'talos_options': ['--disable-e10s'], 09:05:19 INFO - 'tests': ['tp5o']}, 09:05:19 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:05:19 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:05:19 INFO - 'talos_options': ['--disable-e10s', 09:05:19 INFO - '--xperf_path', 09:05:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:05:19 INFO - 'tests': ['tp5n']}, 09:05:19 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:05:19 INFO - 'talos_options': ['--xperf_path', 09:05:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:05:19 INFO - 'tests': ['tp5n']}}, 09:05:19 INFO - 'talos.zip': {'path': '', 09:05:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:05:19 INFO - Running post-action listener: _resource_record_post_action 09:05:19 INFO - [mozharness: 2017-02-17 17:05:19.357947Z] Finished populate-webroot step (success) 09:05:19 INFO - [mozharness: 2017-02-17 17:05:19.358038Z] Running create-virtualenv step. 09:05:19 INFO - Running pre-action listener: _resource_record_pre_action 09:05:19 INFO - Running main action method: create_virtualenv 09:05:19 INFO - Creating virtualenv /builds/slave/test/build/venv 09:05:19 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 09:05:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:05:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:05:19 INFO - Using real prefix '/usr' 09:05:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:05:19 INFO - Installing distribute.............................................................................................................................................................................................done. 09:05:21 INFO - Installing pip.................done. 09:05:21 INFO - Return code: 0 09:05:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:05:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:05:22 INFO - Reading from file tmpfile_stdout 09:05:22 INFO - Output received: 09:05:22 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:05:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:05:22 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')]} 09:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:22 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')]} 09:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:22 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 0xc2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9bd00>, '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 0xf9ca00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9ceb0>, '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': '523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799', '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 09:05:22 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 09:05:22 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 09:05:22 INFO - Using env: {'DISPLAY': ':0', 09:05:22 INFO - 'HOME': '/home/cltbld', 09:05:22 INFO - 'LANG': 'en_US.UTF-8', 09:05:22 INFO - 'LANGUAGE': 'en_US:en', 09:05:22 INFO - 'LOGNAME': 'cltbld', 09:05:22 INFO - 'MAIL': '/var/mail/cltbld', 09:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:22 INFO - 'MOZ_NO_REMOTE': '1', 09:05:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:22 INFO - 'NO_EM_RESTART': '1', 09:05:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:22 INFO - 'PWD': '/builds/slave/test', 09:05:22 INFO - 'SHELL': '/bin/bash', 09:05:22 INFO - 'SHLVL': '1', 09:05:22 INFO - 'TERM': 'linux', 09:05:22 INFO - 'TMOUT': '86400', 09:05:22 INFO - 'USER': 'cltbld', 09:05:22 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799', 09:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:22 INFO - '_': '/tools/buildbot/bin/python'} 09:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:22 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 09:05:22 INFO - Cleaning up... 09:05:22 INFO - Return code: 0 09:05:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:05:22 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')]} 09:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:22 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')]} 09:05:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:22 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 0xc2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9bd00>, '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 0xf9ca00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9ceb0>, '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': '523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799', '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 09:05:22 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 09:05:22 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 09:05:22 INFO - Using env: {'DISPLAY': ':0', 09:05:22 INFO - 'HOME': '/home/cltbld', 09:05:22 INFO - 'LANG': 'en_US.UTF-8', 09:05:22 INFO - 'LANGUAGE': 'en_US:en', 09:05:22 INFO - 'LOGNAME': 'cltbld', 09:05:22 INFO - 'MAIL': '/var/mail/cltbld', 09:05:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:22 INFO - 'MOZ_NO_REMOTE': '1', 09:05:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:22 INFO - 'NO_EM_RESTART': '1', 09:05:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:22 INFO - 'PWD': '/builds/slave/test', 09:05:22 INFO - 'SHELL': '/bin/bash', 09:05:22 INFO - 'SHLVL': '1', 09:05:22 INFO - 'TERM': 'linux', 09:05:22 INFO - 'TMOUT': '86400', 09:05:22 INFO - 'USER': 'cltbld', 09:05:22 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799', 09:05:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:22 INFO - '_': '/tools/buildbot/bin/python'} 09:05:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:22 INFO - Downloading/unpacking psutil>=3.1.1 09:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:05:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:05:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:05:24 INFO - Installing collected packages: psutil 09:05:24 INFO - Running setup.py install for psutil 09:05:24 INFO - building 'psutil._psutil_linux' extension 09:05:24 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 09:05:24 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 09:05:24 INFO - building 'psutil._psutil_posix' extension 09:05:24 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 09:05:25 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 09:05:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:05:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:05:25 INFO - Successfully installed psutil 09:05:25 INFO - Cleaning up... 09:05:25 INFO - Return code: 0 09:05:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:05:25 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')]} 09:05:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:25 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')]} 09:05:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:25 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 0xc2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9bd00>, '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 0xf9ca00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9ceb0>, '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': '523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799', '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 09:05:25 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 09:05:25 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 09:05:25 INFO - Using env: {'DISPLAY': ':0', 09:05:25 INFO - 'HOME': '/home/cltbld', 09:05:25 INFO - 'LANG': 'en_US.UTF-8', 09:05:25 INFO - 'LANGUAGE': 'en_US:en', 09:05:25 INFO - 'LOGNAME': 'cltbld', 09:05:25 INFO - 'MAIL': '/var/mail/cltbld', 09:05:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:25 INFO - 'MOZ_NO_REMOTE': '1', 09:05:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:25 INFO - 'NO_EM_RESTART': '1', 09:05:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:25 INFO - 'PWD': '/builds/slave/test', 09:05:25 INFO - 'SHELL': '/bin/bash', 09:05:25 INFO - 'SHLVL': '1', 09:05:25 INFO - 'TERM': 'linux', 09:05:25 INFO - 'TMOUT': '86400', 09:05:25 INFO - 'USER': 'cltbld', 09:05:25 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799', 09:05:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:25 INFO - '_': '/tools/buildbot/bin/python'} 09:05:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:05:25 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 09:05:25 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 09:05:25 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 09:05:25 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 09:05:25 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 09:05:25 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 09:05:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:05:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:05:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:05:27 INFO - Installing collected packages: mozsystemmonitor 09:05:27 INFO - Running setup.py install for mozsystemmonitor 09:05:27 INFO - Successfully installed mozsystemmonitor 09:05:27 INFO - Cleaning up... 09:05:27 INFO - Return code: 0 09:05:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:27 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 0xc2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9bd00>, '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 0xf9ca00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9ceb0>, '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': '523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799', '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 09:05:27 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 09:05:27 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 09:05:27 INFO - Using env: {'DISPLAY': ':0', 09:05:27 INFO - 'HOME': '/home/cltbld', 09:05:27 INFO - 'LANG': 'en_US.UTF-8', 09:05:27 INFO - 'LANGUAGE': 'en_US:en', 09:05:27 INFO - 'LOGNAME': 'cltbld', 09:05:27 INFO - 'MAIL': '/var/mail/cltbld', 09:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:27 INFO - 'MOZ_NO_REMOTE': '1', 09:05:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:27 INFO - 'NO_EM_RESTART': '1', 09:05:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:27 INFO - 'PWD': '/builds/slave/test', 09:05:27 INFO - 'SHELL': '/bin/bash', 09:05:27 INFO - 'SHLVL': '1', 09:05:27 INFO - 'TERM': 'linux', 09:05:27 INFO - 'TMOUT': '86400', 09:05:27 INFO - 'USER': 'cltbld', 09:05:27 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799', 09:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:27 INFO - '_': '/tools/buildbot/bin/python'} 09:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:27 INFO - Downloading/unpacking jsonschema==2.5.1 09:05:27 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 09:05:27 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 09:05:27 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 09:05:27 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 09:05:27 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 09:05:27 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 09:05:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:05:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:30 INFO - Downloading functools32-3.2.3-2.tar.gz 09:05:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:05:30 INFO - warning: no files found matching '*.txt' 09:05:30 INFO - no previously-included directories found matching 'build' 09:05:30 INFO - no previously-included directories found matching 'dist' 09:05:30 INFO - no previously-included directories found matching '.git*' 09:05:30 INFO - Installing collected packages: jsonschema, functools32 09:05:30 INFO - Running setup.py install for functools32 09:05:30 INFO - warning: no files found matching '*.txt' 09:05:30 INFO - no previously-included directories found matching 'build' 09:05:30 INFO - no previously-included directories found matching 'dist' 09:05:30 INFO - no previously-included directories found matching '.git*' 09:05:30 INFO - Successfully installed jsonschema functools32 09:05:30 INFO - Cleaning up... 09:05:30 INFO - Return code: 0 09:05:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:05: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')]} 09:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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')]} 09:05:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:30 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 0xc2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9bd00>, '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 0xf9ca00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9ceb0>, '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': '523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799', '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 09:05:30 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 09:05:30 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 09:05:30 INFO - Using env: {'DISPLAY': ':0', 09:05:30 INFO - 'HOME': '/home/cltbld', 09:05:30 INFO - 'LANG': 'en_US.UTF-8', 09:05:30 INFO - 'LANGUAGE': 'en_US:en', 09:05:30 INFO - 'LOGNAME': 'cltbld', 09:05:30 INFO - 'MAIL': '/var/mail/cltbld', 09:05:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:30 INFO - 'MOZ_NO_REMOTE': '1', 09:05:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:30 INFO - 'NO_EM_RESTART': '1', 09:05:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:30 INFO - 'PWD': '/builds/slave/test', 09:05:30 INFO - 'SHELL': '/bin/bash', 09:05:30 INFO - 'SHLVL': '1', 09:05:30 INFO - 'TERM': 'linux', 09:05:30 INFO - 'TMOUT': '86400', 09:05:30 INFO - 'USER': 'cltbld', 09:05:30 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799', 09:05:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:30 INFO - '_': '/tools/buildbot/bin/python'} 09:05:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:05:30 INFO - Cleaning up... 09:05:30 INFO - Return code: 0 09:05:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:05: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')]} 09:05:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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')]} 09:05:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:30 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 0xc2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9bd00>, '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 0xf9ca00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9ceb0>, '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': '523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799', '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 09:05:30 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 09:05:30 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 09:05:30 INFO - Using env: {'DISPLAY': ':0', 09:05:30 INFO - 'HOME': '/home/cltbld', 09:05:30 INFO - 'LANG': 'en_US.UTF-8', 09:05:30 INFO - 'LANGUAGE': 'en_US:en', 09:05:30 INFO - 'LOGNAME': 'cltbld', 09:05:30 INFO - 'MAIL': '/var/mail/cltbld', 09:05:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:30 INFO - 'MOZ_NO_REMOTE': '1', 09:05:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:30 INFO - 'NO_EM_RESTART': '1', 09:05:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:30 INFO - 'PWD': '/builds/slave/test', 09:05:30 INFO - 'SHELL': '/bin/bash', 09:05:30 INFO - 'SHLVL': '1', 09:05:30 INFO - 'TERM': 'linux', 09:05:30 INFO - 'TMOUT': '86400', 09:05:30 INFO - 'USER': 'cltbld', 09:05:30 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799', 09:05:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:30 INFO - '_': '/tools/buildbot/bin/python'} 09:05:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:30 INFO - Downloading/unpacking blobuploader==1.2.4 09:05:30 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 09:05:30 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 09:05:30 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 09:05:30 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 09:05:30 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 09:05:30 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 09:05:32 INFO - Downloading blobuploader-1.2.4.tar.gz 09:05:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:05:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:05:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:05:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:05:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:05:33 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 09:05:33 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 09:05:33 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 09:05:33 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 09:05:33 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 09:05:33 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 09:05:33 INFO - Downloading docopt-0.6.1.tar.gz 09:05:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:05:33 INFO - Installing collected packages: blobuploader, requests, docopt 09:05:33 INFO - Running setup.py install for blobuploader 09:05:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:05:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:05:33 INFO - Running setup.py install for requests 09:05:34 INFO - Running setup.py install for docopt 09:05:34 INFO - Successfully installed blobuploader requests docopt 09:05:34 INFO - Cleaning up... 09:05:34 INFO - Return code: 0 09:05:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:34 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 0xc2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9bd00>, '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 0xf9ca00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9ceb0>, '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': '523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799', '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 09:05:34 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 09:05:34 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 09:05:34 INFO - Using env: {'DISPLAY': ':0', 09:05:34 INFO - 'HOME': '/home/cltbld', 09:05:34 INFO - 'LANG': 'en_US.UTF-8', 09:05:34 INFO - 'LANGUAGE': 'en_US:en', 09:05:34 INFO - 'LOGNAME': 'cltbld', 09:05:34 INFO - 'MAIL': '/var/mail/cltbld', 09:05:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:34 INFO - 'MOZ_NO_REMOTE': '1', 09:05:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:34 INFO - 'NO_EM_RESTART': '1', 09:05:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:34 INFO - 'PWD': '/builds/slave/test', 09:05:34 INFO - 'SHELL': '/bin/bash', 09:05:34 INFO - 'SHLVL': '1', 09:05:34 INFO - 'TERM': 'linux', 09:05:34 INFO - 'TMOUT': '86400', 09:05:34 INFO - 'USER': 'cltbld', 09:05:34 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799', 09:05:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:34 INFO - '_': '/tools/buildbot/bin/python'} 09:05:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:34 INFO - Running setup.py (path:/tmp/pip-3uWvfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:34 INFO - Running setup.py (path:/tmp/pip-t4MCgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:34 INFO - Running setup.py (path:/tmp/pip-1U5eSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:34 INFO - Running setup.py (path:/tmp/pip-SdJ1Do-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:34 INFO - Running setup.py (path:/tmp/pip-HuK_Qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:34 INFO - Running setup.py (path:/tmp/pip-kHt3aR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:34 INFO - Running setup.py (path:/tmp/pip-kK4fJ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:35 INFO - Running setup.py (path:/tmp/pip-mcymr6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:35 INFO - Running setup.py (path:/tmp/pip-l_RDLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:35 INFO - Running setup.py (path:/tmp/pip-5VBLap-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:35 INFO - Running setup.py (path:/tmp/pip-nO1HPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:35 INFO - Running setup.py (path:/tmp/pip-k4X7DS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:35 INFO - Running setup.py (path:/tmp/pip-VGpggL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:35 INFO - Running setup.py (path:/tmp/pip-BLqaxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:35 INFO - Running setup.py (path:/tmp/pip-ORHKtE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:35 INFO - Running setup.py (path:/tmp/pip-cWKvO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:35 INFO - Running setup.py (path:/tmp/pip-oyhjWQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:05:35 INFO - Running setup.py install for manifestparser 09:05:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:05:35 INFO - Running setup.py install for mozcrash 09:05:35 INFO - Running setup.py install for mozdebug 09:05:36 INFO - Running setup.py install for mozdevice 09:05:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:05:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:05:36 INFO - Running setup.py install for mozfile 09:05:36 INFO - Running setup.py install for mozhttpd 09:05:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:05:36 INFO - Running setup.py install for mozinfo 09:05:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:05:36 INFO - Running setup.py install for mozInstall 09:05:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:05:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:05:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:05:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:05:36 INFO - Running setup.py install for mozleak 09:05:36 INFO - Running setup.py install for mozlog 09:05:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:05:36 INFO - Running setup.py install for moznetwork 09:05:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:05:36 INFO - Running setup.py install for mozprocess 09:05:37 INFO - Running setup.py install for mozprofile 09:05:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:05:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:05:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:05:37 INFO - Running setup.py install for mozrunner 09:05:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:05:37 INFO - Running setup.py install for mozscreenshot 09:05:37 INFO - Running setup.py install for moztest 09:05:37 INFO - Running setup.py install for mozversion 09:05:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:05:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:05:37 INFO - Cleaning up... 09:05:37 INFO - Return code: 0 09:05:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05:37 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')]} 09:05:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:37 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')]} 09:05:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:37 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 0xc2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9bd00>, '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 0xf9ca00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9ceb0>, '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': '523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799', '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 09:05:37 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 09:05:37 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 09:05:37 INFO - Using env: {'DISPLAY': ':0', 09:05:37 INFO - 'HOME': '/home/cltbld', 09:05:37 INFO - 'LANG': 'en_US.UTF-8', 09:05:37 INFO - 'LANGUAGE': 'en_US:en', 09:05:37 INFO - 'LOGNAME': 'cltbld', 09:05:37 INFO - 'MAIL': '/var/mail/cltbld', 09:05:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:37 INFO - 'MOZ_NO_REMOTE': '1', 09:05:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:37 INFO - 'NO_EM_RESTART': '1', 09:05:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:37 INFO - 'PWD': '/builds/slave/test', 09:05:37 INFO - 'SHELL': '/bin/bash', 09:05:37 INFO - 'SHLVL': '1', 09:05:37 INFO - 'TERM': 'linux', 09:05:37 INFO - 'TMOUT': '86400', 09:05:37 INFO - 'USER': 'cltbld', 09:05:37 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799', 09:05:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:37 INFO - '_': '/tools/buildbot/bin/python'} 09:05:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:05:37 INFO - Running setup.py (path:/tmp/pip-I8k0wG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:05:37 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)) 09:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:05:37 INFO - Running setup.py (path:/tmp/pip-eRMQem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:05:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 09:05:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:05:37 INFO - Running setup.py (path:/tmp/pip-CYAlRB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:05:38 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)) 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:05:38 INFO - Running setup.py (path:/tmp/pip-x8jMBh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:05:38 INFO - Running setup.py (path:/tmp/pip-SQ3yQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:05:38 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)) 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:05:38 INFO - Running setup.py (path:/tmp/pip-5155lW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:05:38 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)) 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:05:38 INFO - Running setup.py (path:/tmp/pip-R8IHs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:05:38 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)) 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:05:38 INFO - Running setup.py (path:/tmp/pip-UnWk_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:05:38 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)) 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:05:38 INFO - Running setup.py (path:/tmp/pip-uDQWDN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:05:38 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)) 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:05:38 INFO - Running setup.py (path:/tmp/pip-JJNGrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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)) 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:05:38 INFO - Running setup.py (path:/tmp/pip-pm2QNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:05:38 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)) 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:05:38 INFO - Running setup.py (path:/tmp/pip-pxg3zA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:05:38 INFO - Running setup.py (path:/tmp/pip-1Ef4WT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:05:38 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)) 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:05:38 INFO - Running setup.py (path:/tmp/pip-8K08ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:38 INFO - Running setup.py (path:/tmp/pip-UoCv0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:05:38 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)) 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:05:38 INFO - Running setup.py (path:/tmp/pip-SyFREf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:05:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 09:05:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:05:38 INFO - Running setup.py (path:/tmp/pip-zrguuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:05:39 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)) 09:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:05:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:05:39 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)) 09:05:39 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:05:39 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:05:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:05:39 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 09:05:39 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 09:05:39 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 09:05:39 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 09:05:39 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 09:05:39 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 09:05:41 INFO - Downloading blessings-1.6.tar.gz 09:05:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:05:41 INFO - Installing collected packages: blessings 09:05:41 INFO - Running setup.py install for blessings 09:05:41 INFO - Successfully installed blessings 09:05:41 INFO - Cleaning up... 09:05:41 INFO - Return code: 0 09:05:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:05:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:41 INFO - Reading from file tmpfile_stdout 09:05:41 INFO - Current package versions: 09:05:41 INFO - argparse == 1.2.1 09:05:41 INFO - blessings == 1.6 09:05:41 INFO - blobuploader == 1.2.4 09:05:41 INFO - docopt == 0.6.1 09:05:41 INFO - functools32 == 3.2.3-2 09:05:41 INFO - jsonschema == 2.5.1 09:05:41 INFO - manifestparser == 1.1 09:05:41 INFO - mozInstall == 1.12 09:05:41 INFO - mozcrash == 1.0 09:05:41 INFO - mozdebug == 0.1 09:05:41 INFO - mozdevice == 0.49 09:05:41 INFO - mozfile == 1.2 09:05:41 INFO - mozhttpd == 0.7 09:05:41 INFO - mozinfo == 0.9 09:05:41 INFO - mozleak == 0.1 09:05:41 INFO - mozlog == 3.4 09:05:41 INFO - moznetwork == 0.27 09:05:41 INFO - mozprocess == 0.24 09:05:41 INFO - mozprofile == 0.28 09:05:41 INFO - mozrunner == 6.13 09:05:41 INFO - mozscreenshot == 0.1 09:05:41 INFO - mozsystemmonitor == 0.3 09:05:41 INFO - moztest == 0.8 09:05:41 INFO - mozversion == 1.4 09:05:41 INFO - psutil == 3.1.1 09:05:41 INFO - requests == 1.2.3 09:05:41 INFO - wsgiref == 0.1.2 09:05:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:05: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')]} 09:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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')]} 09:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05:41 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 0xc2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9bd00>, '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 0xf9ca00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9ceb0>, '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': '523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799', '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 09:05:41 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 09:05:41 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 09:05:41 INFO - Using env: {'DISPLAY': ':0', 09:05:41 INFO - 'HOME': '/home/cltbld', 09:05:41 INFO - 'LANG': 'en_US.UTF-8', 09:05:41 INFO - 'LANGUAGE': 'en_US:en', 09:05:41 INFO - 'LOGNAME': 'cltbld', 09:05:41 INFO - 'MAIL': '/var/mail/cltbld', 09:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:41 INFO - 'MOZ_NO_REMOTE': '1', 09:05:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:41 INFO - 'NO_EM_RESTART': '1', 09:05:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:41 INFO - 'PWD': '/builds/slave/test', 09:05:41 INFO - 'SHELL': '/bin/bash', 09:05:41 INFO - 'SHLVL': '1', 09:05:41 INFO - 'TERM': 'linux', 09:05:41 INFO - 'TMOUT': '86400', 09:05:41 INFO - 'USER': 'cltbld', 09:05:41 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799', 09:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:41 INFO - '_': '/tools/buildbot/bin/python'} 09:05:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:41 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)) 09:05:41 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)) 09:05:41 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)) 09:05:41 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)) 09:05:41 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)) 09:05:41 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)) 09:05:41 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)) 09:05:41 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)) 09:05:41 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)) 09:05:41 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)) 09:05:41 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)) 09:05:41 INFO - Cleaning up... 09:05:41 INFO - Return code: 0 09:05:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:05: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')]} 09:05:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:05:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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')]} 09:05:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:05:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:05: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']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xc2c1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xdf9a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xf9e980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9bd00>, '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 0xf9ca00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9ceb0>, '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': '523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799', '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 09:05: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'] in /builds/slave/test/build 09:05: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 09:05:41 INFO - Using env: {'DISPLAY': ':0', 09:05:41 INFO - 'HOME': '/home/cltbld', 09:05:41 INFO - 'LANG': 'en_US.UTF-8', 09:05:41 INFO - 'LANGUAGE': 'en_US:en', 09:05:41 INFO - 'LOGNAME': 'cltbld', 09:05:41 INFO - 'MAIL': '/var/mail/cltbld', 09:05:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:41 INFO - 'MOZ_NO_REMOTE': '1', 09:05:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:41 INFO - 'NO_EM_RESTART': '1', 09:05:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:41 INFO - 'PWD': '/builds/slave/test', 09:05:41 INFO - 'SHELL': '/bin/bash', 09:05:41 INFO - 'SHLVL': '1', 09:05:41 INFO - 'TERM': 'linux', 09:05:41 INFO - 'TMOUT': '86400', 09:05:41 INFO - 'USER': 'cltbld', 09:05:41 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799', 09:05:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:41 INFO - '_': '/tools/buildbot/bin/python'} 09:05:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:05:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:05:42 INFO - Cleaning up... 09:05:42 INFO - Return code: 0 09:05:42 INFO - Running post-action listener: _resource_record_post_action 09:05:42 INFO - Running post-action listener: _start_resource_monitoring 09:05:42 INFO - Starting resource monitoring. 09:05:42 INFO - [mozharness: 2017-02-17 17:05:42.051952Z] Finished create-virtualenv step (success) 09:05:42 INFO - [mozharness: 2017-02-17 17:05:42.052404Z] Running install step. 09:05:42 INFO - Running pre-action listener: _resource_record_pre_action 09:05:42 INFO - Running main action method: install 09:05:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:05:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:05:42 INFO - Reading from file tmpfile_stdout 09:05:42 INFO - Detecting whether we're running mozinstall >=1.0... 09:05:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:05:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:05:42 INFO - Reading from file tmpfile_stdout 09:05:42 INFO - Output received: 09:05:42 INFO - Usage: mozinstall [options] installer 09:05:42 INFO - Options: 09:05:42 INFO - -h, --help show this help message and exit 09:05:42 INFO - -d DEST, --destination=DEST 09:05:42 INFO - Directory to install application into. [default: 09:05:42 INFO - "/builds/slave/test"] 09:05:42 INFO - --app=APP Application being installed. [default: firefox] 09:05:42 INFO - mkdir: /builds/slave/test/build/application 09:05:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 09:05:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 09:05:58 INFO - Reading from file tmpfile_stdout 09:05:58 INFO - Output received: 09:05:58 INFO - /builds/slave/test/build/application/firefox/firefox 09:05:58 INFO - Running post-action listener: _resource_record_post_action 09:05:58 INFO - [mozharness: 2017-02-17 17:05:58.797173Z] Finished install step (success) 09:05:58 INFO - [mozharness: 2017-02-17 17:05:58.797447Z] Running run-tests step. 09:05:58 INFO - Running pre-action listener: _resource_record_pre_action 09:05:58 INFO - Running main action method: run_tests 09:05:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:05:58 INFO - Python 2.7.3 09:05:58 INFO - Return code: 0 09:05:58 INFO - grabbing minidump binary from tooltool 09:05:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:05:58 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf9bd00>, '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 0xf9ca00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xf9ceb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:05:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:05:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 09:05:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:05:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:05:58 INFO - Return code: 0 09:05:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:05:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:05:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:05:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:05:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:05:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 09:05:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-065 --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 09:05:58 INFO - Using env: {'DISPLAY': ':0', 09:05:58 INFO - 'HOME': '/home/cltbld', 09:05:58 INFO - 'LANG': 'en_US.UTF-8', 09:05:58 INFO - 'LANGUAGE': 'en_US:en', 09:05:58 INFO - 'LOGNAME': 'cltbld', 09:05:58 INFO - 'MAIL': '/var/mail/cltbld', 09:05:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:05:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:05:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:05:58 INFO - 'MOZ_NO_REMOTE': '1', 09:05:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:05:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:05:58 INFO - 'NO_EM_RESTART': '1', 09:05:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:05:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:05:58 INFO - 'PWD': '/builds/slave/test', 09:05:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:05:58 INFO - 'SHELL': '/bin/bash', 09:05:58 INFO - 'SHLVL': '1', 09:05:58 INFO - 'TERM': 'linux', 09:05:58 INFO - 'TMOUT': '86400', 09:05:58 INFO - 'USER': 'cltbld', 09:05:58 INFO - 'XDG_SESSION_COOKIE': '523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799', 09:05:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:05:58 INFO - '_': '/tools/buildbot/bin/python'} 09:05:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-065', '--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 09:05:59 INFO - mozversion application_buildid: 20170217155956 09:05:59 INFO - mozversion application_changeset: 2af97db52557c07ca1dc692bb5406ccafbb704e5 09:05:59 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:05:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:05:59 INFO - mozversion application_name: Firefox 09:05:59 INFO - mozversion application_remotingname: firefox-dev 09:05:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:05:59 INFO - mozversion application_vendor: Mozilla 09:05:59 INFO - mozversion application_version: 53.0a2 09:05:59 INFO - mozversion platform_buildid: 20170217155956 09:05:59 INFO - mozversion platform_changeset: 2af97db52557c07ca1dc692bb5406ccafbb704e5 09:05:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:05:59 INFO - mozversion platform_version: 53.0a2 09:05:59 INFO - using testdate: 1487351159 09:05:59 INFO - actual date: 1487351159 09:05:59 INFO - starting webserver on 'localhost:59092' 09:05:59 INFO - SUITE-START | Running 2 tests 09:05:59 INFO - TEST-START | dromaeo_css 09:05:59 INFO - operating with platform_type : linux_ 09:05:59 INFO - Initialising browser for dromaeo_css test... 09:05:59 INFO - TEST-INFO | started process 26697 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4od1mO/profile http://localhost:59092/getInfo.html) 09:06:02 INFO - PROCESS | 26697 | __metrics Screen width/height:1600/1200 09:06:02 INFO - PROCESS | 26697 | colorDepth:24 09:06:02 INFO - PROCESS | 26697 | Browser inner width/height: 1024/697 09:06:02 INFO - PROCESS | 26697 | __metrics 09:06:03 INFO - PROCESS | 26697 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:06:03 INFO - PROCESS | 26697 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:06:04 INFO - TEST-INFO | 26697: exit 0 09:06:04 INFO - Browser initialized. 09:06:04 INFO - Running cycle 1/1 for dromaeo_css test... 09:06:04 INFO - TEST-INFO | started process 26789 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4od1mO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:06:16 INFO - PROCESS | 26789 | RSS: Main: 139526144 09:06:16 INFO - PROCESS | 26789 | 09:09:17 INFO - PROCESS | 26789 | Cycle 1(1): loaded http://localhost:59092/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59092/tests/dromaeo/cssquery-ext.html) 09:09:18 INFO - PROCESS | 26789 | RSS: Main: 237748224 09:09:18 INFO - PROCESS | 26789 | 09:11:06 INFO - PROCESS | 26789 | ************************* 09:11:06 INFO - PROCESS | 26789 | A coding exception was thrown and uncaught in a Task. 09:11:06 INFO - PROCESS | 26789 | 09:11:06 ERROR - PROCESS | 26789 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:11:06 INFO - PROCESS | 26789 | Full stack: 09:11:06 INFO - PROCESS | 26789 | ************************* 09:12:20 INFO - PROCESS | 26789 | Cycle 1(1): loaded http://localhost:59092/tests/dromaeo/cssquery-ext.html (next: http://localhost:59092/tests/dromaeo/cssquery-jquery.html) 09:12:21 INFO - PROCESS | 26789 | RSS: Main: 228741120 09:12:21 INFO - PROCESS | 26789 | 09:15:22 INFO - PROCESS | 26789 | Cycle 1(1): loaded http://localhost:59092/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59092/tests/dromaeo/cssquery-mootools.html) 09:15:23 INFO - PROCESS | 26789 | RSS: Main: 171728896 09:15:23 INFO - PROCESS | 26789 | 09:18:25 INFO - PROCESS | 26789 | Cycle 1(1): loaded http://localhost:59092/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59092/tests/dromaeo/cssquery-prototype.html) 09:18:26 INFO - PROCESS | 26789 | RSS: Main: 190382080 09:18:26 INFO - PROCESS | 26789 | 09:21:28 INFO - PROCESS | 26789 | Cycle 1(1): loaded http://localhost:59092/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59092/tests/dromaeo/cssquery-yui.html) 09:21:29 INFO - PROCESS | 26789 | RSS: Main: 170041344 09:21:29 INFO - PROCESS | 26789 | 09:24:31 INFO - PROCESS | 26789 | Cycle 1(1): loaded http://localhost:59092/tests/dromaeo/cssquery-yui.html (next: http://localhost:59092/tests/dromaeo/cssquery-dojo.html) 09:24:32 INFO - PROCESS | 26789 | RSS: Main: 266620928 09:24:32 INFO - PROCESS | 26789 | 09:24:32 INFO - PROCESS | 26789 | __start_tp_report 09:24:32 INFO - PROCESS | 26789 | _x_x_mozilla_page_load 09:24:32 INFO - PROCESS | 26789 | _x_x_mozilla_page_load_details 09:24:32 INFO - PROCESS | 26789 | |i|pagename|runs| 09:24:32 INFO - PROCESS | 26789 | |0;dojo.html;3225.242068113993;3259.4784834426496;3277.491988741746;3280.6227283862354;3282.8686852525884;5352.812651557197;5452.6455780374245;5483.177523371496;5489.64317319375;5530.115181570949;5423.620346575742;5477.1510415885605;5480.616356855022;5493.670379777216;5500.064988951878;4902.362692849924;4910.459849416561;4927.039227350668;4952.851414457554;4973.353464049668;4841.2496063110275;4842.66101372904;4859.611231101503;4961.404631444232;4983.775730092137;4863.076015557051;4948.356713627223;4959.132151873426;4967.05625931072;4979.153543897546;4974.602031837462;4988.351514303154;4991.40103187618;4996.400431948153;5022.723750193738;4799.568038876483;4840.757962101916;4877.414710234794;4897.755112244409;4919.0899683558655;5315.920261196085;5376.005438993799;5387.084195686703;5407.756650950677;5455.1544510600925;5821.708914554298;5826.679532625704;5833.300003999505;5834.912476312858;5842.182094506772;5711.286089238845;5822.883542329172;5827;5859.29688437386;5880.235569375996;5353.4646535346155;5377.892442151135;5388.380336261341;5395.406505284415;5479.013777520005;5863.384344643751;5864.266966629171;5864.44287792659;5871.588988770745;5874.324452687995;5666.603337766399;5667.801626943037;5669.829905102853;5673.404292549306;5677.971610142005;5605.103183490622;5647.237622920935;5778.508826749773;5823.301203855564;5839.474447299678;5825.446582574648;5865.178874957509;5865.472107510344;5870.7945221917025;5899.380565040695;5732.484076433141;5772.7113644317615;5774;5774.855628609234;5775.393583673737;4331.6534677225745;4349.869503914888;4354.325079612665;4427;4449.399331090326;4026.697997650188;4027.2549578328103;4031.899202519902;4044.1507283470214;4047.008482921703;5592.384837667853;5605.327360716658;5611.102223644198;5611.7474713637985;5641.012822756002;5719.056355701346;5742.454466825729;5749.252597162342;5777.277840269966;5783.652980821164;5549.084401073858;5555.388907220203;5556.805511807067;5557.499825015768;5579.804706835242;4940.456549779521;4942.629302802305;4952.331435256267;4956.306117143603;4979.377577802775;5854.795082172103;5907.763689452374;5921.052631578927;5921.940780592311;6030.547708921848;5852.385499522659;5856.882862342644;5863.912041319299;5872.677002764889;5905.498032667271;5986.07215881539;6036.7283472244735;6036.849078773066;6047.304559975659;6056.9091463628965;5544.445555444423;5593.664380137205;5595.664260144405;5740.598158128891;5752.741126649227;5723.713814309184;5760.711964401847;5768.769249229984;5816.214811000461;5826.621269617462;5718.714064296852;5719.370869204467;5725.255716756795;5726.370099289158;5749.252597162509;5671.092625179951;5703.173039909273;5727.713614319351;5729.656220626775;5732.942670573408;5546.417626149197;5566.025945459447;5614.157876318585;5631.3242410909315;5682.488576028012;5678.744456499385;5723.141528770551;5731.656100633975;5732.254806875079;5763.077907534775;5585.273914391103;5593;5603.495685388335;5618.269624948731;5619.185218143428 09:24:32 INFO - PROCESS | 26789 | |1;ext.html;579.3800633322347;604.4952464691982;612.0299325568973;637.8469167399826;660.5739298152689;35691.28617427653;47051;47905.28142077867;48031;52207.47792522074;49593.50406495934;50052.249216261785;50095.74952125234;50129.74935125328;50385.236516721925;8670.479771213748;9062.139096785828;9349.719508414759;9352.485613291266;9358.485283309416;8512.276456501173;10889.509972051277;11170.441477926071;11181.44092795361;11508.079353651689;10952.288101273432;10972.506237219304;10976.1219102472;10987;10991.450427478634;11242.831357529643;11266.774664506745;11274.379909104997;11330.093592512661;11330.773384532346;11089.889101109047;11136.109111271078;11161.944190279079;11167.329960202414;11170.553177872875;46956.29565556485;47062.52937470616;47119.29321060187;47226.52773472256;47239;4311.1593239318345;4420.40324556184;4440.378347031418;4495.617872480843;4644.837430689943;31783;31795.979381958678;31981.200469988205;32318.515222271686;33054.834725826215;4653.395058642355;4669.603083737887;4685.1332503486965;4728.952710472886;4771.832985845479;350185;351287;351541;351545;351824;58238.4176158233;58454.70772646109;58552.12171817426;58574.7071264641;58733.41266587279;63011;63051.684741576915;63057.68471157615;63093.369066309664;63142.36857631457;18436.262549498137;18665.626687466174;18668;18676.159572818982;18676.34632787846;12113.515459381702;12419.379031048411;14511;14733;14820.555383338517;19642.50893727668;19844.404667859988;19910.60178796416;19972;20002.799972000386;7340.916814937739;7364.631768411665;7425.621342289245;7597.202293759186;7609.619519024027;958.2382006305004;1004.4525733475274;1022.5347466902541;1023.0792286941812;1032.3083534032066;33437.66562334394;33633;33699.663003370144;34088.82955585256;34653;1131.4569006876582;1181.344353883603;1204.2292932523192;1215.969600759988;1219.3293688471483;15380.615484612974;15583.298751556207;15656.843431565538;15695.607609809846;16033.839661603468;521261;522149;522344;523265;523747;59444.10833837496;59667.70166149142;59921;60103.19690409295;60238;1504.3606467251375;1524.5959820647315;1533.5552689719857;1547.597624617585;1559.898606590568;27994.300142496602;29647.555286671148;29655;30185.547216791325;30342.69657303487;50213;51024.23463647974;51146.232806507185;51286.48713512817;51310.74344628253;458866;460035;460536;461371;463312;25917.48165036651;26298.86850565735;27071.59392609152;27761.861190694726;28349;45069;45139.54860451485;45334.31998519959;45389.092218154794;45516.544834551234;38363.23273534458;38612.80693596626;39060;39131.6086839128;40283.3957490632;37379.43930840985;37643.62356376401;37772;38031.53844620318;39022;38630.61369386382;39539.604603954744;39604.2079158421;39699.40450893297;39704;32527.674723252465;34382.48426273658;34597.13507162341;35063.29873402569;35078.29843403168;25685.743142568335;25915.48169036571;26082.124908841535;26164.73835261623;26171.607425889008 09:24:32 INFO - PROCESS | 26789 | |2;jquery.html;432.61713383655456;433.4473546228558;439.9032212913159;440.19224722633965;452.92204553163447;20759.584808303825;21157.68263476045;22291.77708222917;22414.439639008993;22563.210287639937;20347;20839.0622421991;22192.778072219273;22315.55368892621;22411.55176896461;5865.120231965197;6083.665398403086;6083.847903802418;6086.726097325631;6092.6953652317425;5767.134929760548;5937.732802023897;5969.731362088694;5980;5982.252218472691;5825.359210486843;5951.345352011275;5958.195643588125;5964.821055368346;5965;5986.191864098357;5987.730552125165;6018.127371531147;6020.217371741645;6023.969880150615;5395.406505284415;5414.160805075219;5421.83734487966;5442.836714898559;5466.8359949201185;25962;26039.479210415873;26080.608790867962;26085.478290434086;26357.604635930475;2873.181143374149;2919.7731598984788;2990.7607391408637;2990.925226869324;3013.367192889496;15392.538223853302;15964.600884977852;16104.919475402665;16340.83659163405;16348.182590870409;1984.4641946674317;2042.6221149087467;2050.8359331253464;2052.702358158074;2066.4937090412795;84878;94752.52623736837;101450.49274753653;102456.48771756169;103799.96200037979;11717.531298748125;11882.227655202558;12385.876141238652;12541.122121451594;12831.550895718792;18234.361797337297;18361.449156525327;18367.08164591792;18368.265269389074;18383.90808045978;9046.909530904606;9082.364234503653;9219.907800921905;9317.11487408695;9476.241900647932;8799.12008799115;8959.552022398853;9041.59312830911;9047.81904361909;9150.313726470542;5349.893002139936;5384.515393614593;5391.7304134793885;5461.981007832461;5621.747021383966;2155.6550951847944;2187.13608124793;2202.7466841313135;2250.9549809004056;2251.752307246202;919.7562645898843;929.4284015330524;937.0582564522612;957.7414098193589;968.3270127261486;20840.1663933444;20845.89577052105;21117.68323475149;21392.78607213939;21520.677189842165;949.2785483032944;954.236610711428;958.496789185683;960.4957397366438;960.6061514778908;11478.426078696031;11548.480318385693;11680.123990700731;11700.648980530597;11743.17797754149;668458;673075;677907;678643;682134;107651;110121.44939275412;111079;112519.43740281246;113906.43046784878;1060.5068643081004;1066.4880857188593;1096.5065720425841;1101.6474728086935;1102.8235482322789;17796.46610601684;18037.549061273046;18072.90963545174;18118;18425.907870460564;45457.54542454665;45832.31251531163;46042;47046;48264;59538.40461595502;59843.40156598378;60665.69667151636;66629.66685166737;68330.3166968324;9111;9346.906530934875;9562.139407453362;9634.855477167988;9753;10826.512806923865;14733.55799326022;14856.40574377056;14902.1803800792;14973.625659358604;11944.701382465508;12210.084243681582;12319.199252048587;12379.133460657667;12716;12244.44899979521;12718.364081796059;12785.232886026868;12844.807327889903;13051.608451746462;12113.636590902288;12214.450349734461;12509.74980500403;12539.561115360919;12937.417816198482;8151.30713889326;8436.957815210884;9277.768055798659;9547;9891.307608467627;9312.580933858128;12217.572384966483;12619.432125554556;12656.873431265569;12761.361931903182 09:24:32 INFO - PROCESS | 26789 | |3;mootools.html;1448.637840539865;1455.6870272891326;1457.7084583083383;1488.9106653600784;1491.1649476293276;8132.146124656914;8655.134486551358;8656.91343086569;8659.567021648916;8662.74011779646;7602.467827252094;7863.292303692667;7869.881951770713;8063.6371363288645;8508;2349.7650234976536;2426.4419183587784;2430.234476140019;2448.2288079255068;2449.155041510676;2390;2433.853968761871;2449.1917667169882;2461.040194324215;2461.2247142150163;2387.6776635154292;2394.437307232799;2398.2925037114005;2410.288964755401;2410.288964755401;2265.920692775753;2295.0934380919443;2296.334063121701;2300.4708916949194;2303.389601755536;2243.5176437065948;2272.5682120397237;2329.033451117784;2330.8251881108986;2331.7201935767816;8317.376196785204;8365.8326833463;8375.162483751637;8382.664693412256;8386.664533418718;5116.974415127937;5238.8428347149265;5240.423553409122;5240.711760853152;5243.737813109329;3277.4919887417486;3380.594328680574;3414.197663549064;3455.775374600643;3467.7225821934185;1343.167236313492;1408.3591965655705;1413.3781136299995;1438.101186758276;1459.3651761483682;11281.266717663326;11305.717357066056;11344.092472602171;11344.773104537946;11359.943200283946;4373.409589705349;4665.673402861835;4683.8360657376825;4724.385829842098;4726.102040612342;9720.465374404475;9723.416595004323;9725.56234969428;9731;9734.659286924923;5320.068987927175;5321.973390133025;5328.786848526093;5330.653507521999;5331.093714068617;4388.385626012361;4768.546988036131;4818.060478206786;4878.36581244443;4938.38270216223;3847.7498962567342;4081.3673880548563;4194.2450358935075;4199.328107502846;4206.936895946563;1345.4080204709896;1370.136813807295;1373.1006190944947;1376.2361889151616;1380.9378577964017;1041.9270651054353;1048.7797562511957;1050.1703654113317;1054.7204990677476;1057.513543769859;5434.11053712824;5724.313082430135;5727.341355744059;5915.319738230072;5972.163897054415;1052.6473631333588;1053.2890299048113;1075.2580719303655;1087.3910610058392;1093.3494570730402;3868.83934819553;3925.9803700981884;4046.352583586612;4082;4099.139180772071;9707.077827606367;10088.646897358558;10094.343867648578;10096.646617368357;10112.494375281207;9722.951385243028;9842.212622990144;9846.655367062118;9858;9865.901340986642;7688.231176882379;7786.532808031537;7791.4156438267355;7793.2596403341595;7793.766187014286;5658.094704847369;5706.258186435737;5761;5774.48029677331;5874.882502349844;9114.726558203265;9117.498537580232;9123.224525915371;9138.17756401927;9226.907730922605;8960.102355475388;9189;9354;9397.859032114387;9425;6576.638284894377;7403.51877127985;7470.8879366810625;7484.32641062307;7489.887651685338;7506.24937506245;7714.652840622073;7814.960925195338;7936;8097.433179677601;7165.3551180394015;7250.782476525713;7259.854802904018;7309.890351644836;7530.774076777706;6981.476389270927;7035.964820175866;7138.678759455941;7168.498205125591;7250.347468727839;6283.49732021428;6422.42198202164;6429.453496452854;6445.419912207736;6449.161608990801;4676.625869930329;4720.834770783006;4728.3380326753595;4770.069836381872;4824.565789079;4839.540243676845;4913.975430122827;5018.197088465974;5075.467075956972;5107.310513080686 09:24:32 INFO - PROCESS | 26789 | |4;prototype.html;391.0965669303908;402.2819267607322;404.6297637661539;408.2712358440181;408.6812286416595;5391.676499410039;5439.292891924054;5442.619016668835;5444.156155795853;5467.343918729753;5113.721569607598;5137.922931156036;5257.789688412468;5265.341832270966;5323.22813192087;4224.345226489883;4251.5960983706655;4252.8511502097435;4255.936015996001;4264.168487145008;4255.17024180285;4283.92229768562;4284.7429154250685;4291.699581029329;4293.935590966138;3951.486306780129;4009.3985902114623;4215.45199124115;4217.557156498569;4258.5954334338185;4217.704760666755;4227.577242275748;4243.511996120424;4253.383259427381;4253.829846806139;3858.421236814472;3868.1103346230243;3874.767513949144;3881.3789793633164;3892.8442862285474;5122.257272695476;5179.896402071975;5182.818601348972;5208.479152084799;5299.761510732026;4944;4950.490100519341;4972.676776009584;4993.350864387643;4993.752811234923;5589.9379117967865;5602.4957753802355;5623.7469313880565;5625.396761922832;5638.605297629168;3874.244522318149;4066.674666026711;4089.427480152781;4108.36320370343;4301.225779359714;5772.913406298909;5784.16129661201;5786.797462088806;5792.362840087587;5804.245448091763;4197.118605092904;4198.6011328923705;4212.157568486315;4213.367994800743;4239.321708526621;4190.601892820177;4200.411942328076;4221.2190744712325;4265.360195970629;4269.573042695768;4747.406574178228;4764.4282686077195;4783.736894470768;4788.61691064714;4813.350197723263;5587.318087318029;5597.188407680864;5619.241402410622;5634.915476267859;5661.46216109469;1335.30564106664;1378.8069670246173;1390.5967269491734;1407.7606806842862;1412.8799052080687;919.6827094652334;973.3429934793986;987.2003677021636;987.6247026130168;996.0487734213808;5308.177232528964;5308.602494403584;5334.91997620036;5357.812476563302;5370.3287089113865;5406.675599464044;5545.362283337387;5553.251140685386;5576;5610.354809196994;5209.5775464409235;5264.868378290496;5265.236540701577;5268.4994925482015;5273.604479664041;2921.6494020717223;2923.9122826315242;2925.224815423872;2946.9410611787644;2958.600588920511;5572.693501857437;5589.776408943597;5682.119271512922;5762.781329188293;5797.826065218051;5538.418466061086;5548.8624831909365;5561.221428999943;5581.916271255935;5626.718664066781;5705.71471426427;5718.142278658234;5743.10981797822;5766.625169363978;5791.305043394736;5416.8104116355735;5481.9036192762405;5717.142428635738;5753.367129615655;5764.279465066867;5669.886602268014;5695.202671625892;5715.171300161536;5726.341470730919;5735;5822.679752613647;5935.228420305332;5964.224650795542;6015.187949626919;6021.698915054142;4150.688698347576;4177.412583218357;4207.537170911259;4209.158168366278;4216.262154123077;5821.883562328645;5823.7379317929945;5852.707364631837;5853.385394533512;5865.970670146622;5507.944920550904;5630.380658127685;5672.688002159921;5711.8857622848145;5732.971335143297;5597.816851428028;5604.663720176803;5605.663660180402;5609.635373700697;5619.522340600931;5350.7324633767375;5358.705271210121;5513.696746678971;5621.381648018796;5659.094544872801;5542.4734650209775;5550.475448090411;5583.41374155724;5586.832395028156;5598.664080155204;5474.479924407175;5482.5888058394985;5515.751791169488;5536.944630553804;5561.805336813192 09:24:32 INFO - PROCESS | 26789 | |5;yui.html;823.7684661431161;837.61469723927;862.2196911794828;917.8164367126574;944.1879983214434;16987.74518382225;17248.74126888096;17254.39609613664;17330;17426.999999999985;16042.75935860963;16453.095079770606;16548.66902661946;16761.748573771372;16785.83214167858;828.3621611359265;841.9073901870789;845.3659755183612;845.71245776436;846.0862268749767;707.1514182980418;727.5125665803924;824.6247957179498;842.7303262955857;850.7532815483503;897.5960817632059;899.0110878034176;899.2086963472135;899.8065415935572;900.2123142250531;886.0032463478555;886.8536691445936;887.0287035695902;887.3832686283035;887.8845750052517;547.3650565344221;559.7593034994951;630.1430055125027;642.601587016053;650.6193876582205;14159.85840141606;14221.715565688732;14244.92877535616;14246.358913848902;14252.501162459264;14810.185439800807;15094.924525377413;15134.545963621109;15244.161571113584;15269.083854968738;13411.597652070355;13447.394867230998;13522.256275904821;13614.795778063337;13876.236806975612;3941.1329507508303;4496.775161241925;4526.23054080807;4608.677392582521;4688.132695451318;70766;81659;82173.58913205395;82195.58902205511;82844.58577707133;12061.638150855488;12231.266124032409;12252;12331.075169362333;12518.374081295899;22441.663375049386;22622;22654.773452265596;23010;23143.07427702873;8092.473989190684;8273.089960104384;8366.163383661707;8392.538410387366;8540.060593334729;4718.95281047192;4912.828051018198;4930.8275896266605;4964;4979.128652485873;3703.4259689748133;3801.486799282117;3809.7523660961947;3812.961870381316;3814.3324918139215;638.7445021991241;640.5068097564942;642.6176425027102;645.4545908707134;651.8142329436088;608.1850320570369;627.9843003924939;628.707650942314;633.3998934374418;634.7080343042252;10783;10949.233553651167;11098.500567474483;11102.2783519071;11239.887601124048;844.1980118887082;847.6990668312784;852.1691350932915;853.9573021349032;861.8922634670666;5421.430749771296;5461.726913654302;5525.475079867406;5550.222968784293;5606.6636001840025;78455.21544784479;78543.21456785359;78716.21283787204;81613.18386816175;85300.57349713212;56384.71807640936;58893.70553147292;60603;64442.677786610766;66965;59342.406575934554;59507;59914.40085599088;60264.397356026755;60477;10369.533370998473;10678.8398174029;11287.7742445149;11558.248713833575;11974.64076077719;38152;40293.39559906662;40370.59629403786;40652.79673601613;41727.791361043;52817;53125.46874531205;54152.187717185065;54264.45735542594;56010.71994640001;13668.863311367157;13781.655458613615;13843.792343115063;13888.375023123781;14068;16097;16137.273822678242;16217.756733648768;16265.918670406572;16921.15394230259;13984.580462586138;14249.786253206417;14256.358463868943;14931.552053438414;14977.1013739176;15033.924830376216;15064;15274.312655930287;15354.23228838576;15501;13244.498082494962;13281.203127812361;13346.799798003232;13385.732285354043;13545.661358466117;10837.729056773329;11380.658580242605;11538.480768365276;11738.237014594024;11743.471543780379;11785.646430607096;11887.28676279426;11937.701557460785;11938.58214962472;11948.940255299016 09:24:32 INFO - PROCESS | 26789 | __end_tp_report 09:24:32 INFO - PROCESS | 26789 | __start_cc_report 09:24:32 INFO - PROCESS | 26789 | _x_x_mozilla_cycle_collect,946 09:24:32 INFO - PROCESS | 26789 | __end_cc_report 09:24:32 INFO - PROCESS | 26789 | __startTimestamp1487352272040__endTimestamp 09:24:32 INFO - PROCESS | 26789 | 09:24:32 INFO - PROCESS | 26789 | ------- Summary: start ------- 09:24:32 INFO - PROCESS | 26789 | Number of tests: 6 09:24:32 INFO - PROCESS | 26789 | 09:24:32 INFO - PROCESS | 26789 | [#0] dojo.html Cycles:165 Average:5397.49 Median:5611.75 stddev:596.15 (10.6%) stddev-sans-first:573.11 09:24:32 INFO - PROCESS | 26789 | Values: 3225.2 3259.5 3277.5 3280.6 3282.9 5352.8 5452.6 5483.2 5489.6 5530.1 5423.6 5477.2 5480.6 5493.7 5500.1 4902.4 4910.5 4927.0 4952.9 4973.4 4841.2 4842.7 4859.6 4961.4 4983.8 4863.1 4948.4 4959.1 4967.1 4979.2 4974.6 4988.4 4991.4 4996.4 5022.7 4799.6 4840.8 4877.4 4897.8 4919.1 5315.9 5376.0 5387.1 5407.8 5455.2 5821.7 5826.7 5833.3 5834.9 5842.2 5711.3 5822.9 5827.0 5859.3 5880.2 5353.5 5377.9 5388.4 5395.4 5479.0 5863.4 5864.3 5864.4 5871.6 5874.3 5666.6 5667.8 5669.8 5673.4 5678.0 5605.1 5647.2 5778.5 5823.3 5839.5 5825.4 5865.2 5865.5 5870.8 5899.4 5732.5 5772.7 5774.0 5774.9 5775.4 4331.7 4349.9 4354.3 4427.0 4449.4 4026.7 4027.3 4031.9 4044.2 4047.0 5592.4 5605.3 5611.1 5611.7 5641.0 5719.1 5742.5 5749.3 5777.3 5783.7 5549.1 5555.4 5556.8 5557.5 5579.8 4940.5 4942.6 4952.3 4956.3 4979.4 5854.8 5907.8 5921.1 5921.9 6030.5 5852.4 5856.9 5863.9 5872.7 5905.5 5986.1 6036.7 6036.8 6047.3 6056.9 5544.4 5593.7 5595.7 5740.6 5752.7 5723.7 5760.7 5768.8 5816.2 5826.6 5718.7 5719.4 5725.3 5726.4 5749.3 5671.1 5703.2 5727.7 5729.7 5732.9 5546.4 5566.0 5614.2 5631.3 5682.5 5678.7 5723.1 5731.7 5732.3 5763.1 5585.3 5593.0 5603.5 5618.3 5619.2 09:24:32 INFO - PROCESS | 26789 | 09:24:32 INFO - PROCESS | 26789 | [#1] ext.html Cycles:180 Average:61038.93 Median:37707.81 stddev:119267.57 (316.3%) stddev-sans-first:119515.76 09:24:32 INFO - PROCESS | 26789 | Values: 579.4 604.5 612.0 637.8 660.6 35691.3 47051.0 47905.3 48031.0 52207.5 49593.5 50052.2 50095.7 50129.7 50385.2 8670.5 9062.1 9349.7 9352.5 9358.5 8512.3 10889.5 11170.4 11181.4 11508.1 10952.3 10972.5 10976.1 10987.0 10991.5 11242.8 11266.8 11274.4 11330.1 11330.8 11089.9 11136.1 11161.9 11167.3 11170.6 46956.3 47062.5 47119.3 47226.5 47239.0 4311.2 4420.4 4440.4 4495.6 4644.8 31783.0 31796.0 31981.2 32318.5 33054.8 4653.4 4669.6 4685.1 4729.0 4771.8 350185.0 351287.0 351541.0 351545.0 351824.0 58238.4 58454.7 58552.1 58574.7 58733.4 63011.0 63051.7 63057.7 63093.4 63142.4 18436.3 18665.6 18668.0 18676.2 18676.3 12113.5 12419.4 14511.0 14733.0 14820.6 19642.5 19844.4 19910.6 19972.0 20002.8 7340.9 7364.6 7425.6 7597.2 7609.6 958.2 1004.5 1022.5 1023.1 1032.3 33437.7 33633.0 33699.7 34088.8 34653.0 1131.5 1181.3 1204.2 1216.0 1219.3 15380.6 15583.3 15656.8 15695.6 16033.8 521261.0 522149.0 522344.0 523265.0 523747.0 59444.1 59667.7 59921.0 60103.2 60238.0 1504.4 1524.6 1533.6 1547.6 1559.9 27994.3 29647.6 29655.0 30185.5 30342.7 50213.0 51024.2 51146.2 51286.5 51310.7 458866.0 460035.0 460536.0 461371.0 463312.0 25917.5 26298.9 27071.6 27761.9 28349.0 45069.0 45139.5 45334.3 45389.1 45516.5 38363.2 38612.8 39060.0 39131.6 40283.4 37379.4 37643.6 37772.0 38031.5 39022.0 38630.6 39539.6 39604.2 39699.4 39704.0 32527.7 34382.5 34597.1 35063.3 35078.3 25685.7 25915.5 26082.1 26164.7 26171.6 09:24:32 INFO - PROCESS | 26789 | 09:24:32 INFO - PROCESS | 26789 | [#2] jquery.html Cycles:180 Average:36300.78 Median:26221.54 stddev:111153.23 (423.9%) stddev-sans-first:111432.42 09:24:32 INFO - PROCESS | 26789 | Values: 432.6 433.4 439.9 440.2 452.9 20759.6 21157.7 22291.8 22414.4 22563.2 20347.0 20839.1 22192.8 22315.6 22411.6 5865.1 6083.7 6083.8 6086.7 6092.7 5767.1 5937.7 5969.7 5980.0 5982.3 5825.4 5951.3 5958.2 5964.8 5965.0 5986.2 5987.7 6018.1 6020.2 6024.0 5395.4 5414.2 5421.8 5442.8 5466.8 25962.0 26039.5 26080.6 26085.5 26357.6 2873.2 2919.8 2990.8 2990.9 3013.4 15392.5 15964.6 16104.9 16340.8 16348.2 1984.5 2042.6 2050.8 2052.7 2066.5 84878.0 94752.5 101450.5 102456.5 103800.0 11717.5 11882.2 12385.9 12541.1 12831.6 18234.4 18361.4 18367.1 18368.3 18383.9 9046.9 9082.4 9219.9 9317.1 9476.2 8799.1 8959.6 9041.6 9047.8 9150.3 5349.9 5384.5 5391.7 5462.0 5621.7 2155.7 2187.1 2202.7 2251.0 2251.8 919.8 929.4 937.1 957.7 968.3 20840.2 20845.9 21117.7 21392.8 21520.7 949.3 954.2 958.5 960.5 960.6 11478.4 11548.5 11680.1 11700.6 11743.2 668458.0 673075.0 677907.0 678643.0 682134.0 107651.0 110121.4 111079.0 112519.4 113906.4 1060.5 1066.5 1096.5 1101.6 1102.8 17796.5 18037.5 18072.9 18118.0 18425.9 45457.5 45832.3 46042.0 47046.0 48264.0 59538.4 59843.4 60665.7 66629.7 68330.3 9111.0 9346.9 9562.1 9634.9 9753.0 10826.5 14733.6 14856.4 14902.2 14973.6 11944.7 12210.1 12319.2 12379.1 12716.0 12244.4 12718.4 12785.2 12844.8 13051.6 12113.6 12214.5 12509.7 12539.6 12937.4 8151.3 8437.0 9277.8 9547.0 9891.3 9312.6 12217.6 12619.4 12656.9 12761.4 09:24:32 INFO - PROCESS | 26789 | 09:24:32 INFO - PROCESS | 26789 | [#3] mootools.html Cycles:180 Average:5522.81 Median:4978.29 stddev:2953.99 (59.3%) stddev-sans-first:2946.40 09:24:32 INFO - PROCESS | 26789 | Values: 1448.6 1455.7 1457.7 1488.9 1491.2 8132.1 8655.1 8656.9 8659.6 8662.7 7602.5 7863.3 7869.9 8063.6 8508.0 2349.8 2426.4 2430.2 2448.2 2449.2 2390.0 2433.9 2449.2 2461.0 2461.2 2387.7 2394.4 2398.3 2410.3 2410.3 2265.9 2295.1 2296.3 2300.5 2303.4 2243.5 2272.6 2329.0 2330.8 2331.7 8317.4 8365.8 8375.2 8382.7 8386.7 5117.0 5238.8 5240.4 5240.7 5243.7 3277.5 3380.6 3414.2 3455.8 3467.7 1343.2 1408.4 1413.4 1438.1 1459.4 11281.3 11305.7 11344.1 11344.8 11359.9 4373.4 4665.7 4683.8 4724.4 4726.1 9720.5 9723.4 9725.6 9731.0 9734.7 5320.1 5322.0 5328.8 5330.7 5331.1 4388.4 4768.5 4818.1 4878.4 4938.4 3847.7 4081.4 4194.2 4199.3 4206.9 1345.4 1370.1 1373.1 1376.2 1380.9 1041.9 1048.8 1050.2 1054.7 1057.5 5434.1 5724.3 5727.3 5915.3 5972.2 1052.6 1053.3 1075.3 1087.4 1093.3 3868.8 3926.0 4046.4 4082.0 4099.1 9707.1 10088.6 10094.3 10096.6 10112.5 9723.0 9842.2 9846.7 9858.0 9865.9 7688.2 7786.5 7791.4 7793.3 7793.8 5658.1 5706.3 5761.0 5774.5 5874.9 9114.7 9117.5 9123.2 9138.2 9226.9 8960.1 9189.0 9354.0 9397.9 9425.0 6576.6 7403.5 7470.9 7484.3 7489.9 7506.2 7714.7 7815.0 7936.0 8097.4 7165.4 7250.8 7259.9 7309.9 7530.8 6981.5 7036.0 7138.7 7168.5 7250.3 6283.5 6422.4 6429.5 6445.4 6449.2 4676.6 4720.8 4728.3 4770.1 4824.6 4839.5 4914.0 5018.2 5075.5 5107.3 09:24:32 INFO - PROCESS | 26789 | 09:24:32 INFO - PROCESS | 26789 | [#4] prototype.html Cycles:180 Average:4720.24 Median:5364.52 stddev:1358.15 (25.3%) stddev-sans-first:1322.52 09:24:32 INFO - PROCESS | 26789 | Values: 391.1 402.3 404.6 408.3 408.7 5391.7 5439.3 5442.6 5444.2 5467.3 5113.7 5137.9 5257.8 5265.3 5323.2 4224.3 4251.6 4252.9 4255.9 4264.2 4255.2 4283.9 4284.7 4291.7 4293.9 3951.5 4009.4 4215.5 4217.6 4258.6 4217.7 4227.6 4243.5 4253.4 4253.8 3858.4 3868.1 3874.8 3881.4 3892.8 5122.3 5179.9 5182.8 5208.5 5299.8 4944.0 4950.5 4972.7 4993.4 4993.8 5589.9 5602.5 5623.7 5625.4 5638.6 3874.2 4066.7 4089.4 4108.4 4301.2 5772.9 5784.2 5786.8 5792.4 5804.2 4197.1 4198.6 4212.2 4213.4 4239.3 4190.6 4200.4 4221.2 4265.4 4269.6 4747.4 4764.4 4783.7 4788.6 4813.4 5587.3 5597.2 5619.2 5634.9 5661.5 1335.3 1378.8 1390.6 1407.8 1412.9 919.7 973.3 987.2 987.6 996.0 5308.2 5308.6 5334.9 5357.8 5370.3 5406.7 5545.4 5553.3 5576.0 5610.4 5209.6 5264.9 5265.2 5268.5 5273.6 2921.6 2923.9 2925.2 2946.9 2958.6 5572.7 5589.8 5682.1 5762.8 5797.8 5538.4 5548.9 5561.2 5581.9 5626.7 5705.7 5718.1 5743.1 5766.6 5791.3 5416.8 5481.9 5717.1 5753.4 5764.3 5669.9 5695.2 5715.2 5726.3 5735.0 5822.7 5935.2 5964.2 6015.2 6021.7 4150.7 4177.4 4207.5 4209.2 4216.3 5821.9 5823.7 5852.7 5853.4 5866.0 5507.9 5630.4 5672.7 5711.9 5733.0 5597.8 5604.7 5605.7 5609.6 5619.5 5350.7 5358.7 5513.7 5621.4 5659.1 5542.5 5550.5 5583.4 5586.8 5598.7 5474.5 5482.6 5515.8 5536.9 5561.8 09:24:32 INFO - PROCESS | 26789 | 09:24:32 INFO - PROCESS | 26789 | [#5] yui.html Cycles:180 Average:17796.90 Median:23112.28 stddev:21818.38 (94.4%) stddev-sans-first:21842.35 09:24:32 INFO - PROCESS | 26789 | Values: 823.8 837.6 862.2 917.8 944.2 16987.7 17248.7 17254.4 17330.0 17427.0 16042.8 16453.1 16548.7 16761.7 16785.8 828.4 841.9 845.4 845.7 846.1 707.2 727.5 824.6 842.7 850.8 897.6 899.0 899.2 899.8 900.2 886.0 886.9 887.0 887.4 887.9 547.4 559.8 630.1 642.6 650.6 14159.9 14221.7 14244.9 14246.4 14252.5 14810.2 15094.9 15134.5 15244.2 15269.1 13411.6 13447.4 13522.3 13614.8 13876.2 3941.1 4496.8 4526.2 4608.7 4688.1 70766.0 81659.0 82173.6 82195.6 82844.6 12061.6 12231.3 12252.0 12331.1 12518.4 22441.7 22622.0 22654.8 23010.0 23143.1 8092.5 8273.1 8366.2 8392.5 8540.1 4719.0 4912.8 4930.8 4964.0 4979.1 3703.4 3801.5 3809.8 3813.0 3814.3 638.7 640.5 642.6 645.5 651.8 608.2 628.0 628.7 633.4 634.7 10783.0 10949.2 11098.5 11102.3 11239.9 844.2 847.7 852.2 854.0 861.9 5421.4 5461.7 5525.5 5550.2 5606.7 78455.2 78543.2 78716.2 81613.2 85300.6 56384.7 58893.7 60603.0 64442.7 66965.0 59342.4 59507.0 59914.4 60264.4 60477.0 10369.5 10678.8 11287.8 11558.2 11974.6 38152.0 40293.4 40370.6 40652.8 41727.8 52817.0 53125.5 54152.2 54264.5 56010.7 13668.9 13781.7 13843.8 13888.4 14068.0 16097.0 16137.3 16217.8 16265.9 16921.2 13984.6 14249.8 14256.4 14931.6 14977.1 15033.9 15064.0 15274.3 15354.2 15501.0 13244.5 13281.2 13346.8 13385.7 13545.7 10837.7 11380.7 11538.5 11738.2 11743.5 11785.6 11887.3 11937.7 11938.6 11948.9 09:24:32 INFO - PROCESS | 26789 | -------- Summary: end -------- 09:24:32 INFO - PROCESS | 26789 | 09:24:32 INFO - TEST-INFO | 26789: exit 0 09:24:32 INFO - TEST-OK | dromaeo_css | took 1113714ms 09:24:32 INFO - TEST-START | kraken 09:24:32 INFO - operating with platform_type : linux_ 09:24:32 INFO - Initialising browser for kraken test... 09:24:32 INFO - TEST-INFO | started process 27110 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQLloKo/profile http://localhost:59092/getInfo.html) 09:24:36 INFO - PROCESS | 27110 | __metrics Screen width/height:1600/1200 09:24:36 INFO - PROCESS | 27110 | colorDepth:24 09:24:36 INFO - PROCESS | 27110 | Browser inner width/height: 1024/697 09:24:36 INFO - PROCESS | 27110 | __metrics 09:24:37 INFO - PROCESS | 27110 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 09:24:37 INFO - PROCESS | 27110 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:24:37 INFO - PROCESS | 27110 | console.error: PushService: 09:24:37 INFO - PROCESS | 27110 | stateChangeProcessEnqueue: Error transitioning state 09:24:37 INFO - PROCESS | 27110 | UnknownError 09:24:38 INFO - TEST-INFO | 27110: exit 0 09:24:38 INFO - Browser initialized. 09:24:38 INFO - Running cycle 1/1 for kraken test... 09:24:38 INFO - TEST-INFO | started process 27202 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQLloKo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:50 INFO - PROCESS | 27202 | RSS: Main: 138752000 09:24:50 INFO - PROCESS | 27202 | 09:24:52 INFO - PROCESS | 27202 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59092/tests/kraken/driver.html?testName=audio-beat-detection) 09:24:53 INFO - PROCESS | 27202 | RSS: Main: 183250944 09:24:53 INFO - PROCESS | 27202 | 09:24:56 INFO - PROCESS | 27202 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59092/tests/kraken/driver.html?testName=audio-dft) 09:24:56 INFO - PROCESS | 27202 | RSS: Main: 172617728 09:24:56 INFO - PROCESS | 27202 | 09:24:59 INFO - PROCESS | 27202 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59092/tests/kraken/driver.html?testName=audio-fft) 09:25:00 INFO - PROCESS | 27202 | RSS: Main: 264769536 09:25:00 INFO - PROCESS | 27202 | 09:25:02 INFO - PROCESS | 27202 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59092/tests/kraken/driver.html?testName=audio-oscillator) 09:25:02 INFO - PROCESS | 27202 | RSS: Main: 170414080 09:25:02 INFO - PROCESS | 27202 | 09:25:04 INFO - PROCESS | 27202 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59092/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:25:05 INFO - PROCESS | 27202 | RSS: Main: 172916736 09:25:05 INFO - PROCESS | 27202 | 09:25:08 INFO - PROCESS | 27202 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59092/tests/kraken/driver.html?testName=imaging-darkroom) 09:25:08 INFO - PROCESS | 27202 | RSS: Main: 211988480 09:25:08 INFO - PROCESS | 27202 | 09:25:12 INFO - PROCESS | 27202 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59092/tests/kraken/driver.html?testName=imaging-desaturate) 09:25:12 INFO - PROCESS | 27202 | RSS: Main: 210350080 09:25:12 INFO - PROCESS | 27202 | 09:25:15 INFO - PROCESS | 27202 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59092/tests/kraken/driver.html?testName=json-parse-financial) 09:25:16 INFO - PROCESS | 27202 | RSS: Main: 208531456 09:25:16 INFO - PROCESS | 27202 | 09:25:17 INFO - PROCESS | 27202 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59092/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:25:18 INFO - PROCESS | 27202 | RSS: Main: 170315776 09:25:18 INFO - PROCESS | 27202 | 09:25:20 INFO - PROCESS | 27202 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59092/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:25:20 INFO - PROCESS | 27202 | RSS: Main: 179113984 09:25:20 INFO - PROCESS | 27202 | 09:25:22 INFO - PROCESS | 27202 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59092/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:25:23 INFO - PROCESS | 27202 | RSS: Main: 187535360 09:25:23 INFO - PROCESS | 27202 | 09:25:25 INFO - PROCESS | 27202 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59092/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:25:26 INFO - PROCESS | 27202 | RSS: Main: 197603328 09:25:26 INFO - PROCESS | 27202 | 09:25:29 INFO - PROCESS | 27202 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59092/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:25:29 INFO - PROCESS | 27202 | RSS: Main: 192831488 09:25:29 INFO - PROCESS | 27202 | 09:25:31 INFO - PROCESS | 27202 | Cycle 1(1): loaded http://localhost:59092/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59092/tests/kraken/driver.html?testName=ai-astar) 09:25:31 INFO - PROCESS | 27202 | RSS: Main: 243564544 09:25:31 INFO - PROCESS | 27202 | 09:25:31 INFO - PROCESS | 27202 | __start_tp_report 09:25:31 INFO - PROCESS | 27202 | _x_x_mozilla_page_load 09:25:31 INFO - PROCESS | 27202 | _x_x_mozilla_page_load_details 09:25:31 INFO - PROCESS | 27202 | |i|pagename|runs| 09:25:31 INFO - PROCESS | 27202 | |0;ai-astar;111;113;112;111;113;113;112;111;112;112 09:25:31 INFO - PROCESS | 27202 | |1;audio-beat-detection;141;118;118;144;122;118;117;122;136;117 09:25:31 INFO - PROCESS | 27202 | |2;audio-dft;161;161;162;167;160;159;160;161;162;160 09:25:31 INFO - PROCESS | 27202 | |3;audio-fft;74;75;75;110;76;77;76;76;94;76 09:25:31 INFO - PROCESS | 27202 | |4;audio-oscillator;82;81;103;82;84;82;97;82;82;95 09:25:31 INFO - PROCESS | 27202 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;117;117;117 09:25:31 INFO - PROCESS | 27202 | |6;imaging-darkroom;146;145;146;146;146;147;146;146;146;146 09:25:31 INFO - PROCESS | 27202 | |7;imaging-desaturate;96;96;96;95;95;97;96;96;96;95 09:25:31 INFO - PROCESS | 27202 | |8;json-parse-financial;48;48;48;48;48;50;49;49;48;47 09:25:31 INFO - PROCESS | 27202 | |9;json-stringify-tinderbox;63;67;64;65;64;63;64;65;63;64 09:25:31 INFO - PROCESS | 27202 | |10;stanford-crypto-aes;84;82;77;76;76;84;77;83;76;76 09:25:31 INFO - PROCESS | 27202 | |11;stanford-crypto-ccm;124;124;123;122;119;130;120;133;173;124 09:25:31 INFO - PROCESS | 27202 | |12;stanford-crypto-pbkdf2;156;157;160;158;159;155;160;164;166;158 09:25:31 INFO - PROCESS | 27202 | |13;stanford-crypto-sha256-iterative;60;60;61;62;59;62;61;61;61;59 09:25:31 INFO - PROCESS | 27202 | __end_tp_report 09:25:31 INFO - PROCESS | 27202 | __start_cc_report 09:25:31 INFO - PROCESS | 27202 | _x_x_mozilla_cycle_collect,1542 09:25:31 INFO - PROCESS | 27202 | __end_cc_report 09:25:31 INFO - PROCESS | 27202 | __startTimestamp1487352331642__endTimestamp 09:25:31 INFO - PROCESS | 27202 | 09:25:31 INFO - PROCESS | 27202 | ------- Summary: start ------- 09:25:31 INFO - PROCESS | 27202 | Number of tests: 14 09:25:31 INFO - PROCESS | 27202 | 09:25:31 INFO - PROCESS | 27202 | [#0] ai-astar Cycles:10 Average:112.00 Median:112.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 09:25:31 INFO - PROCESS | 27202 | Values: 111.0 113.0 112.0 111.0 113.0 113.0 112.0 111.0 112.0 112.0 09:25:31 INFO - PROCESS | 27202 | 09:25:31 INFO - PROCESS | 27202 | [#1] audio-beat-detection Cycles:10 Average:125.30 Median:122.00 stddev:10.70 (8.8%) stddev-sans-first:9.72 09:25:31 INFO - PROCESS | 27202 | Values: 141.0 118.0 118.0 144.0 122.0 118.0 117.0 122.0 136.0 117.0 09:25:31 INFO - PROCESS | 27202 | 09:25:31 INFO - PROCESS | 27202 | [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:2.21 (1.4%) stddev-sans-first:2.35 09:25:31 INFO - PROCESS | 27202 | Values: 161.0 161.0 162.0 167.0 160.0 159.0 160.0 161.0 162.0 160.0 09:25:31 INFO - PROCESS | 27202 | 09:25:31 INFO - PROCESS | 27202 | [#3] audio-fft Cycles:10 Average:80.90 Median:76.00 stddev:11.77 (15.5%) stddev-sans-first:12.22 09:25:31 INFO - PROCESS | 27202 | Values: 74.0 75.0 75.0 110.0 76.0 77.0 76.0 76.0 94.0 76.0 09:25:31 INFO - PROCESS | 27202 | 09:25:31 INFO - PROCESS | 27202 | [#4] audio-oscillator Cycles:10 Average:87.00 Median:82.00 stddev:8.10 (9.9%) stddev-sans-first:8.38 09:25:31 INFO - PROCESS | 27202 | Values: 82.0 81.0 103.0 82.0 84.0 82.0 97.0 82.0 82.0 95.0 09:25:31 INFO - PROCESS | 27202 | 09:25:31 INFO - PROCESS | 27202 | [#5] imaging-gaussian-blur Cycles:10 Average:117.10 Median:117.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 09:25:31 INFO - PROCESS | 27202 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 117.0 117.0 09:25:31 INFO - PROCESS | 27202 | 09:25:31 INFO - PROCESS | 27202 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 09:25:31 INFO - PROCESS | 27202 | Values: 146.0 145.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 09:25:31 INFO - PROCESS | 27202 | 09:25:31 INFO - PROCESS | 27202 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 09:25:31 INFO - PROCESS | 27202 | Values: 96.0 96.0 96.0 95.0 95.0 97.0 96.0 96.0 96.0 95.0 09:25:31 INFO - PROCESS | 27202 | 09:25:31 INFO - PROCESS | 27202 | [#8] json-parse-financial Cycles:10 Average:48.30 Median:48.00 stddev:0.82 (1.7%) stddev-sans-first:0.87 09:25:31 INFO - PROCESS | 27202 | Values: 48.0 48.0 48.0 48.0 48.0 50.0 49.0 49.0 48.0 47.0 09:25:31 INFO - PROCESS | 27202 | 09:25:31 INFO - PROCESS | 27202 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:1.23 (1.9%) stddev-sans-first:1.22 09:25:31 INFO - PROCESS | 27202 | Values: 63.0 67.0 64.0 65.0 64.0 63.0 64.0 65.0 63.0 64.0 09:25:31 INFO - PROCESS | 27202 | 09:25:31 INFO - PROCESS | 27202 | [#10] stanford-crypto-aes Cycles:10 Average:79.10 Median:79.50 stddev:3.63 (4.6%) stddev-sans-first:3.40 09:25:31 INFO - PROCESS | 27202 | Values: 84.0 82.0 77.0 76.0 76.0 84.0 77.0 83.0 76.0 76.0 09:25:31 INFO - PROCESS | 27202 | 09:25:31 INFO - PROCESS | 27202 | [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:124.00 stddev:15.96 (12.9%) stddev-sans-first:16.82 09:25:31 INFO - PROCESS | 27202 | Values: 124.0 124.0 123.0 122.0 119.0 130.0 120.0 133.0 173.0 124.0 09:25:31 INFO - PROCESS | 27202 | 09:25:31 INFO - PROCESS | 27202 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.30 Median:159.50 stddev:3.43 (2.2%) stddev-sans-first:3.43 09:25:31 INFO - PROCESS | 27202 | Values: 156.0 157.0 160.0 158.0 159.0 155.0 160.0 164.0 166.0 158.0 09:25:31 INFO - PROCESS | 27202 | 09:25:31 INFO - PROCESS | 27202 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:60.60 Median:61.00 stddev:1.07 (1.8%) stddev-sans-first:1.12 09:25:31 INFO - PROCESS | 27202 | Values: 60.0 60.0 61.0 62.0 59.0 62.0 61.0 61.0 61.0 59.0 09:25:31 INFO - PROCESS | 27202 | -------- Summary: end -------- 09:25:31 INFO - PROCESS | 27202 | 09:25:32 INFO - TEST-INFO | 27202: exit 0 09:25:32 INFO - TEST-OK | kraken | took 59913ms 09:25:32 INFO - SUITE-END | took 1173s 09:25:32 INFO - Completed test suite (00:19:33) 09:25:32 INFO - javascript benchmark 09:25:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3225.242068113993, 3259.4784834426496, 3277.491988741746, 3280.6227283862354, 3282.8686852525884, 5352.812651557197, 5452.6455780374245, 5483.177523371496, 5489.64317319375, 5530.115181570949, 5423.620346575742, 5477.1510415885605, 5480.616356855022, 5493.670379777216, 5500.064988951878, 4902.362692849924, 4910.459849416561, 4927.039227350668, 4952.851414457554, 4973.353464049668, 4841.2496063110275, 4842.66101372904, 4859.611231101503, 4961.404631444232, 4983.775730092137, 4863.076015557051, 4948.356713627223, 4959.132151873426, 4967.05625931072, 4979.153543897546, 4974.602031837462, 4988.351514303154, 4991.40103187618, 4996.400431948153, 5022.723750193738, 4799.568038876483, 4840.757962101916, 4877.414710234794, 4897.755112244409, 4919.0899683558655, 5315.920261196085, 5376.005438993799, 5387.084195686703, 5407.756650950677, 5455.1544510600925, 5821.708914554298, 5826.679532625704, 5833.300003999505, 5834.912476312858, 5842.182094506772, 5711.286089238845, 5822.883542329172, 5827.0, 5859.29688437386, 5880.235569375996, 5353.4646535346155, 5377.892442151135, 5388.380336261341, 5395.406505284415, 5479.013777520005, 5863.384344643751, 5864.266966629171, 5864.44287792659, 5871.588988770745, 5874.324452687995, 5666.603337766399, 5667.801626943037, 5669.829905102853, 5673.404292549306, 5677.971610142005, 5605.103183490622, 5647.237622920935, 5778.508826749773, 5823.301203855564, 5839.474447299678, 5825.446582574648, 5865.178874957509, 5865.472107510344, 5870.7945221917025, 5899.380565040695, 5732.484076433141, 5772.7113644317615, 5774.0, 5774.855628609234, 5775.393583673737, 4331.6534677225745, 4349.869503914888, 4354.325079612665, 4427.0, 4449.399331090326, 4026.697997650188, 4027.2549578328103, 4031.899202519902, 4044.1507283470214, 4047.008482921703, 5592.384837667853, 5605.327360716658, 5611.102223644198, 5611.7474713637985, 5641.012822756002, 5719.056355701346, 5742.454466825729, 5749.252597162342, 5777.277840269966, 5783.652980821164, 5549.084401073858, 5555.388907220203, 5556.805511807067, 5557.499825015768, 5579.804706835242, 4940.456549779521, 4942.629302802305, 4952.331435256267, 4956.306117143603, 4979.377577802775, 5854.795082172103, 5907.763689452374, 5921.052631578927, 5921.940780592311, 6030.547708921848, 5852.385499522659, 5856.882862342644, 5863.912041319299, 5872.677002764889, 5905.498032667271, 5986.07215881539, 6036.7283472244735, 6036.849078773066, 6047.304559975659, 6056.9091463628965, 5544.445555444423, 5593.664380137205, 5595.664260144405, 5740.598158128891, 5752.741126649227, 5723.713814309184, 5760.711964401847, 5768.769249229984, 5816.214811000461, 5826.621269617462, 5718.714064296852, 5719.370869204467, 5725.255716756795, 5726.370099289158, 5749.252597162509, 5671.092625179951, 5703.173039909273, 5727.713614319351, 5729.656220626775, 5732.942670573408, 5546.417626149197, 5566.025945459447, 5614.157876318585, 5631.3242410909315, 5682.488576028012, 5678.744456499385, 5723.141528770551, 5731.656100633975, 5732.254806875079, 5763.077907534775, 5585.273914391103, 5593.0, 5603.495685388335, 5618.269624948731, 5619.185218143428], "value": 5358.8927392367395, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.3800633322347, 604.4952464691982, 612.0299325568973, 637.8469167399826, 660.5739298152689, 35691.28617427653, 47051.0, 47905.28142077867, 48031.0, 52207.47792522074, 49593.50406495934, 50052.249216261785, 50095.74952125234, 50129.74935125328, 50385.236516721925, 8670.479771213748, 9062.139096785828, 9349.719508414759, 9352.485613291266, 9358.485283309416, 8512.276456501173, 10889.509972051277, 11170.441477926071, 11181.44092795361, 11508.079353651689, 10952.288101273432, 10972.506237219304, 10976.1219102472, 10987.0, 10991.450427478634, 11242.831357529643, 11266.774664506745, 11274.379909104997, 11330.093592512661, 11330.773384532346, 11089.889101109047, 11136.109111271078, 11161.944190279079, 11167.329960202414, 11170.553177872875, 46956.29565556485, 47062.52937470616, 47119.29321060187, 47226.52773472256, 47239.0, 4311.1593239318345, 4420.40324556184, 4440.378347031418, 4495.617872480843, 4644.837430689943, 31783.0, 31795.979381958678, 31981.200469988205, 32318.515222271686, 33054.834725826215, 4653.395058642355, 4669.603083737887, 4685.1332503486965, 4728.952710472886, 4771.832985845479, 350185.0, 351287.0, 351541.0, 351545.0, 351824.0, 58238.4176158233, 58454.70772646109, 58552.12171817426, 58574.7071264641, 58733.41266587279, 63011.0, 63051.684741576915, 63057.68471157615, 63093.369066309664, 63142.36857631457, 18436.262549498137, 18665.626687466174, 18668.0, 18676.159572818982, 18676.34632787846, 12113.515459381702, 12419.379031048411, 14511.0, 14733.0, 14820.555383338517, 19642.50893727668, 19844.404667859988, 19910.60178796416, 19972.0, 20002.799972000386, 7340.916814937739, 7364.631768411665, 7425.621342289245, 7597.202293759186, 7609.619519024027, 958.2382006305004, 1004.4525733475274, 1022.5347466902541, 1023.0792286941812, 1032.3083534032066, 33437.66562334394, 33633.0, 33699.663003370144, 34088.82955585256, 34653.0, 1131.4569006876582, 1181.344353883603, 1204.2292932523192, 1215.969600759988, 1219.3293688471483, 15380.615484612974, 15583.298751556207, 15656.843431565538, 15695.607609809846, 16033.839661603468, 521261.0, 522149.0, 522344.0, 523265.0, 523747.0, 59444.10833837496, 59667.70166149142, 59921.0, 60103.19690409295, 60238.0, 1504.3606467251375, 1524.5959820647315, 1533.5552689719857, 1547.597624617585, 1559.898606590568, 27994.300142496602, 29647.555286671148, 29655.0, 30185.547216791325, 30342.69657303487, 50213.0, 51024.23463647974, 51146.232806507185, 51286.48713512817, 51310.74344628253, 458866.0, 460035.0, 460536.0, 461371.0, 463312.0, 25917.48165036651, 26298.86850565735, 27071.59392609152, 27761.861190694726, 28349.0, 45069.0, 45139.54860451485, 45334.31998519959, 45389.092218154794, 45516.544834551234, 38363.23273534458, 38612.80693596626, 39060.0, 39131.6086839128, 40283.3957490632, 37379.43930840985, 37643.62356376401, 37772.0, 38031.53844620318, 39022.0, 38630.61369386382, 39539.604603954744, 39604.2079158421, 39699.40450893297, 39704.0, 32527.674723252465, 34382.48426273658, 34597.13507162341, 35063.29873402569, 35078.29843403168, 25685.743142568335, 25915.48169036571, 26082.124908841535, 26164.73835261623, 26171.607425889008], "value": 21020.77080909623, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [432.61713383655456, 433.4473546228558, 439.9032212913159, 440.19224722633965, 452.92204553163447, 20759.584808303825, 21157.68263476045, 22291.77708222917, 22414.439639008993, 22563.210287639937, 20347.0, 20839.0622421991, 22192.778072219273, 22315.55368892621, 22411.55176896461, 5865.120231965197, 6083.665398403086, 6083.847903802418, 6086.726097325631, 6092.6953652317425, 5767.134929760548, 5937.732802023897, 5969.731362088694, 5980.0, 5982.252218472691, 5825.359210486843, 5951.345352011275, 5958.195643588125, 5964.821055368346, 5965.0, 5986.191864098357, 5987.730552125165, 6018.127371531147, 6020.217371741645, 6023.969880150615, 5395.406505284415, 5414.160805075219, 5421.83734487966, 5442.836714898559, 5466.8359949201185, 25962.0, 26039.479210415873, 26080.608790867962, 26085.478290434086, 26357.604635930475, 2873.181143374149, 2919.7731598984788, 2990.7607391408637, 2990.925226869324, 3013.367192889496, 15392.538223853302, 15964.600884977852, 16104.919475402665, 16340.83659163405, 16348.182590870409, 1984.4641946674317, 2042.6221149087467, 2050.8359331253464, 2052.702358158074, 2066.4937090412795, 84878.0, 94752.52623736837, 101450.49274753653, 102456.48771756169, 103799.96200037979, 11717.531298748125, 11882.227655202558, 12385.876141238652, 12541.122121451594, 12831.550895718792, 18234.361797337297, 18361.449156525327, 18367.08164591792, 18368.265269389074, 18383.90808045978, 9046.909530904606, 9082.364234503653, 9219.907800921905, 9317.11487408695, 9476.241900647932, 8799.12008799115, 8959.552022398853, 9041.59312830911, 9047.81904361909, 9150.313726470542, 5349.893002139936, 5384.515393614593, 5391.7304134793885, 5461.981007832461, 5621.747021383966, 2155.6550951847944, 2187.13608124793, 2202.7466841313135, 2250.9549809004056, 2251.752307246202, 919.7562645898843, 929.4284015330524, 937.0582564522612, 957.7414098193589, 968.3270127261486, 20840.1663933444, 20845.89577052105, 21117.68323475149, 21392.78607213939, 21520.677189842165, 949.2785483032944, 954.236610711428, 958.496789185683, 960.4957397366438, 960.6061514778908, 11478.426078696031, 11548.480318385693, 11680.123990700731, 11700.648980530597, 11743.17797754149, 668458.0, 673075.0, 677907.0, 678643.0, 682134.0, 107651.0, 110121.44939275412, 111079.0, 112519.43740281246, 113906.43046784878, 1060.5068643081004, 1066.4880857188593, 1096.5065720425841, 1101.6474728086935, 1102.8235482322789, 17796.46610601684, 18037.549061273046, 18072.90963545174, 18118.0, 18425.907870460564, 45457.54542454665, 45832.31251531163, 46042.0, 47046.0, 48264.0, 59538.40461595502, 59843.40156598378, 60665.69667151636, 66629.66685166737, 68330.3166968324, 9111.0, 9346.906530934875, 9562.139407453362, 9634.855477167988, 9753.0, 10826.512806923865, 14733.55799326022, 14856.40574377056, 14902.1803800792, 14973.625659358604, 11944.701382465508, 12210.084243681582, 12319.199252048587, 12379.133460657667, 12716.0, 12244.44899979521, 12718.364081796059, 12785.232886026868, 12844.807327889903, 13051.608451746462, 12113.636590902288, 12214.450349734461, 12509.74980500403, 12539.561115360919, 12937.417816198482, 8151.30713889326, 8436.957815210884, 9277.768055798659, 9547.0, 9891.307608467627, 9312.580933858128, 12217.572384966483, 12619.432125554556, 12656.873431265569, 12761.361931903182], "value": 10215.594094644788, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1448.637840539865, 1455.6870272891326, 1457.7084583083383, 1488.9106653600784, 1491.1649476293276, 8132.146124656914, 8655.134486551358, 8656.91343086569, 8659.567021648916, 8662.74011779646, 7602.467827252094, 7863.292303692667, 7869.881951770713, 8063.6371363288645, 8508.0, 2349.7650234976536, 2426.4419183587784, 2430.234476140019, 2448.2288079255068, 2449.155041510676, 2390.0, 2433.853968761871, 2449.1917667169882, 2461.040194324215, 2461.2247142150163, 2387.6776635154292, 2394.437307232799, 2398.2925037114005, 2410.288964755401, 2410.288964755401, 2265.920692775753, 2295.0934380919443, 2296.334063121701, 2300.4708916949194, 2303.389601755536, 2243.5176437065948, 2272.5682120397237, 2329.033451117784, 2330.8251881108986, 2331.7201935767816, 8317.376196785204, 8365.8326833463, 8375.162483751637, 8382.664693412256, 8386.664533418718, 5116.974415127937, 5238.8428347149265, 5240.423553409122, 5240.711760853152, 5243.737813109329, 3277.4919887417486, 3380.594328680574, 3414.197663549064, 3455.775374600643, 3467.7225821934185, 1343.167236313492, 1408.3591965655705, 1413.3781136299995, 1438.101186758276, 1459.3651761483682, 11281.266717663326, 11305.717357066056, 11344.092472602171, 11344.773104537946, 11359.943200283946, 4373.409589705349, 4665.673402861835, 4683.8360657376825, 4724.385829842098, 4726.102040612342, 9720.465374404475, 9723.416595004323, 9725.56234969428, 9731.0, 9734.659286924923, 5320.068987927175, 5321.973390133025, 5328.786848526093, 5330.653507521999, 5331.093714068617, 4388.385626012361, 4768.546988036131, 4818.060478206786, 4878.36581244443, 4938.38270216223, 3847.7498962567342, 4081.3673880548563, 4194.2450358935075, 4199.328107502846, 4206.936895946563, 1345.4080204709896, 1370.136813807295, 1373.1006190944947, 1376.2361889151616, 1380.9378577964017, 1041.9270651054353, 1048.7797562511957, 1050.1703654113317, 1054.7204990677476, 1057.513543769859, 5434.11053712824, 5724.313082430135, 5727.341355744059, 5915.319738230072, 5972.163897054415, 1052.6473631333588, 1053.2890299048113, 1075.2580719303655, 1087.3910610058392, 1093.3494570730402, 3868.83934819553, 3925.9803700981884, 4046.352583586612, 4082.0, 4099.139180772071, 9707.077827606367, 10088.646897358558, 10094.343867648578, 10096.646617368357, 10112.494375281207, 9722.951385243028, 9842.212622990144, 9846.655367062118, 9858.0, 9865.901340986642, 7688.231176882379, 7786.532808031537, 7791.4156438267355, 7793.2596403341595, 7793.766187014286, 5658.094704847369, 5706.258186435737, 5761.0, 5774.48029677331, 5874.882502349844, 9114.726558203265, 9117.498537580232, 9123.224525915371, 9138.17756401927, 9226.907730922605, 8960.102355475388, 9189.0, 9354.0, 9397.859032114387, 9425.0, 6576.638284894377, 7403.51877127985, 7470.8879366810625, 7484.32641062307, 7489.887651685338, 7506.24937506245, 7714.652840622073, 7814.960925195338, 7936.0, 8097.433179677601, 7165.3551180394015, 7250.782476525713, 7259.854802904018, 7309.890351644836, 7530.774076777706, 6981.476389270927, 7035.964820175866, 7138.678759455941, 7168.498205125591, 7250.347468727839, 6283.49732021428, 6422.42198202164, 6429.453496452854, 6445.419912207736, 6449.161608990801, 4676.625869930329, 4720.834770783006, 4728.3380326753595, 4770.069836381872, 4824.565789079, 4839.540243676845, 4913.975430122827, 5018.197088465974, 5075.467075956972, 5107.310513080686], "value": 4552.478758855525, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.0965669303908, 402.2819267607322, 404.6297637661539, 408.2712358440181, 408.6812286416595, 5391.676499410039, 5439.292891924054, 5442.619016668835, 5444.156155795853, 5467.343918729753, 5113.721569607598, 5137.922931156036, 5257.789688412468, 5265.341832270966, 5323.22813192087, 4224.345226489883, 4251.5960983706655, 4252.8511502097435, 4255.936015996001, 4264.168487145008, 4255.17024180285, 4283.92229768562, 4284.7429154250685, 4291.699581029329, 4293.935590966138, 3951.486306780129, 4009.3985902114623, 4215.45199124115, 4217.557156498569, 4258.5954334338185, 4217.704760666755, 4227.577242275748, 4243.511996120424, 4253.383259427381, 4253.829846806139, 3858.421236814472, 3868.1103346230243, 3874.767513949144, 3881.3789793633164, 3892.8442862285474, 5122.257272695476, 5179.896402071975, 5182.818601348972, 5208.479152084799, 5299.761510732026, 4944.0, 4950.490100519341, 4972.676776009584, 4993.350864387643, 4993.752811234923, 5589.9379117967865, 5602.4957753802355, 5623.7469313880565, 5625.396761922832, 5638.605297629168, 3874.244522318149, 4066.674666026711, 4089.427480152781, 4108.36320370343, 4301.225779359714, 5772.913406298909, 5784.16129661201, 5786.797462088806, 5792.362840087587, 5804.245448091763, 4197.118605092904, 4198.6011328923705, 4212.157568486315, 4213.367994800743, 4239.321708526621, 4190.601892820177, 4200.411942328076, 4221.2190744712325, 4265.360195970629, 4269.573042695768, 4747.406574178228, 4764.4282686077195, 4783.736894470768, 4788.61691064714, 4813.350197723263, 5587.318087318029, 5597.188407680864, 5619.241402410622, 5634.915476267859, 5661.46216109469, 1335.30564106664, 1378.8069670246173, 1390.5967269491734, 1407.7606806842862, 1412.8799052080687, 919.6827094652334, 973.3429934793986, 987.2003677021636, 987.6247026130168, 996.0487734213808, 5308.177232528964, 5308.602494403584, 5334.91997620036, 5357.812476563302, 5370.3287089113865, 5406.675599464044, 5545.362283337387, 5553.251140685386, 5576.0, 5610.354809196994, 5209.5775464409235, 5264.868378290496, 5265.236540701577, 5268.4994925482015, 5273.604479664041, 2921.6494020717223, 2923.9122826315242, 2925.224815423872, 2946.9410611787644, 2958.600588920511, 5572.693501857437, 5589.776408943597, 5682.119271512922, 5762.781329188293, 5797.826065218051, 5538.418466061086, 5548.8624831909365, 5561.221428999943, 5581.916271255935, 5626.718664066781, 5705.71471426427, 5718.142278658234, 5743.10981797822, 5766.625169363978, 5791.305043394736, 5416.8104116355735, 5481.9036192762405, 5717.142428635738, 5753.367129615655, 5764.279465066867, 5669.886602268014, 5695.202671625892, 5715.171300161536, 5726.341470730919, 5735.0, 5822.679752613647, 5935.228420305332, 5964.224650795542, 6015.187949626919, 6021.698915054142, 4150.688698347576, 4177.412583218357, 4207.537170911259, 4209.158168366278, 4216.262154123077, 5821.883562328645, 5823.7379317929945, 5852.707364631837, 5853.385394533512, 5865.970670146622, 5507.944920550904, 5630.380658127685, 5672.688002159921, 5711.8857622848145, 5732.971335143297, 5597.816851428028, 5604.663720176803, 5605.663660180402, 5609.635373700697, 5619.522340600931, 5350.7324633767375, 5358.705271210121, 5513.696746678971, 5621.381648018796, 5659.094544872801, 5542.4734650209775, 5550.475448090411, 5583.41374155724, 5586.832395028156, 5598.664080155204, 5474.479924407175, 5482.5888058394985, 5515.751791169488, 5536.944630553804, 5561.805336813192], "value": 4302.555274368327, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [823.7684661431161, 837.61469723927, 862.2196911794828, 917.8164367126574, 944.1879983214434, 16987.74518382225, 17248.74126888096, 17254.39609613664, 17330.0, 17426.999999999985, 16042.75935860963, 16453.095079770606, 16548.66902661946, 16761.748573771372, 16785.83214167858, 828.3621611359265, 841.9073901870789, 845.3659755183612, 845.71245776436, 846.0862268749767, 707.1514182980418, 727.5125665803924, 824.6247957179498, 842.7303262955857, 850.7532815483503, 897.5960817632059, 899.0110878034176, 899.2086963472135, 899.8065415935572, 900.2123142250531, 886.0032463478555, 886.8536691445936, 887.0287035695902, 887.3832686283035, 887.8845750052517, 547.3650565344221, 559.7593034994951, 630.1430055125027, 642.601587016053, 650.6193876582205, 14159.85840141606, 14221.715565688732, 14244.92877535616, 14246.358913848902, 14252.501162459264, 14810.185439800807, 15094.924525377413, 15134.545963621109, 15244.161571113584, 15269.083854968738, 13411.597652070355, 13447.394867230998, 13522.256275904821, 13614.795778063337, 13876.236806975612, 3941.1329507508303, 4496.775161241925, 4526.23054080807, 4608.677392582521, 4688.132695451318, 70766.0, 81659.0, 82173.58913205395, 82195.58902205511, 82844.58577707133, 12061.638150855488, 12231.266124032409, 12252.0, 12331.075169362333, 12518.374081295899, 22441.663375049386, 22622.0, 22654.773452265596, 23010.0, 23143.07427702873, 8092.473989190684, 8273.089960104384, 8366.163383661707, 8392.538410387366, 8540.060593334729, 4718.95281047192, 4912.828051018198, 4930.8275896266605, 4964.0, 4979.128652485873, 3703.4259689748133, 3801.486799282117, 3809.7523660961947, 3812.961870381316, 3814.3324918139215, 638.7445021991241, 640.5068097564942, 642.6176425027102, 645.4545908707134, 651.8142329436088, 608.1850320570369, 627.9843003924939, 628.707650942314, 633.3998934374418, 634.7080343042252, 10783.0, 10949.233553651167, 11098.500567474483, 11102.2783519071, 11239.887601124048, 844.1980118887082, 847.6990668312784, 852.1691350932915, 853.9573021349032, 861.8922634670666, 5421.430749771296, 5461.726913654302, 5525.475079867406, 5550.222968784293, 5606.6636001840025, 78455.21544784479, 78543.21456785359, 78716.21283787204, 81613.18386816175, 85300.57349713212, 56384.71807640936, 58893.70553147292, 60603.0, 64442.677786610766, 66965.0, 59342.406575934554, 59507.0, 59914.40085599088, 60264.397356026755, 60477.0, 10369.533370998473, 10678.8398174029, 11287.7742445149, 11558.248713833575, 11974.64076077719, 38152.0, 40293.39559906662, 40370.59629403786, 40652.79673601613, 41727.791361043, 52817.0, 53125.46874531205, 54152.187717185065, 54264.45735542594, 56010.71994640001, 13668.863311367157, 13781.655458613615, 13843.792343115063, 13888.375023123781, 14068.0, 16097.0, 16137.273822678242, 16217.756733648768, 16265.918670406572, 16921.15394230259, 13984.580462586138, 14249.786253206417, 14256.358463868943, 14931.552053438414, 14977.1013739176, 15033.924830376216, 15064.0, 15274.312655930287, 15354.23228838576, 15501.0, 13244.498082494962, 13281.203127812361, 13346.799798003232, 13385.732285354043, 13545.661358466117, 10837.729056773329, 11380.658580242605, 11538.480768365276, 11738.237014594024, 11743.471543780379, 11785.646430607096, 11887.28676279426, 11937.701557460785, 11938.58214962472, 11948.940255299016], "value": 7594.575602076252, "unit": "score"}], "name": "dromaeo_css", "value": 7451.645912526586, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 112.0, 111.0, 113.0, 113.0, 112.0, 111.0, 112.0, 112.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 118.0, 118.0, 144.0, 122.0, 118.0, 117.0, 122.0, 136.0, 117.0], "value": 125.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 167.0, 160.0, 159.0, 160.0, 161.0, 162.0, 160.0], "value": 161.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 110.0, 76.0, 77.0, 76.0, 76.0, 94.0, 76.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 103.0, 82.0, 84.0, 82.0, 97.0, 82.0, 82.0, 95.0], "value": 87.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 97.0, 96.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 48.0, 48.0, 48.0, 48.0, 50.0, 49.0, 49.0, 48.0, 47.0], "value": 48.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 64.0, 65.0, 64.0, 63.0, 64.0, 65.0, 63.0, 64.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 82.0, 77.0, 76.0, 76.0, 84.0, 77.0, 83.0, 76.0, 76.0], "value": 79.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 124.0, 123.0, 122.0, 119.0, 130.0, 120.0, 133.0, 173.0, 124.0], "value": 129.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 157.0, 160.0, 158.0, 159.0, 155.0, 160.0, 164.0, 166.0, 158.0], "value": 159.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 62.0, 59.0, 62.0, 61.0, 61.0, 61.0, 59.0], "value": 60.6, "unit": "score"}], "name": "kraken", "value": 1466.0999999999997, "alertThreshold": 2.0}]} 09:25:32 INFO - Return code: 0 09:25:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:25:32 ERROR - # TBPL SUCCESS # 09:25:32 INFO - Running post-action listener: _resource_record_post_action 09:25:32 INFO - [mozharness: 2017-02-17 17:25:32.939415Z] Finished run-tests step (success) 09:25:32 INFO - Running post-run listener: _resource_record_post_run 09:25:33 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 282624; Write bytes: 365363200; Read time: 68; Write time: 222292 09:25:33 INFO - TinderboxPrint: CPU usage
13.0% 09:25:33 INFO - TinderboxPrint: I/O read bytes / time
282,624 / 68 09:25:33 INFO - TinderboxPrint: I/O write bytes / time
365,363,200 / 222,292 09:25:33 INFO - TinderboxPrint: CPU idle
8,262.0 (87.0%) 09:25:33 INFO - TinderboxPrint: CPU user
1,191.7 (12.5%) 09:25:33 INFO - TinderboxPrint: Swap in / out
0 / 0 09:25:33 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110202880; Read time: 0; Write time: 96672 09:25:33 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 282624; Write bytes: 255160320; Read time: 68; Write time: 125620 09:25:33 INFO - Running post-run listener: _upload_blobber_files 09:25:33 INFO - Blob upload gear active. 09:25:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:25:33 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 09:25:33 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', 'Mozilla-Aurora-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:25:33 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 Mozilla-Aurora-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:25:33 INFO - (blobuploader) - INFO - Open directory for files ... 09:25:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:25:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:25:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:34 INFO - (blobuploader) - INFO - Done attempting. 09:25:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:25:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:25:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:38 INFO - (blobuploader) - INFO - Done attempting. 09:25:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:25:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:25:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:38 INFO - (blobuploader) - INFO - Done attempting. 09:25:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:25:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:25:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:25:40 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:25:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:25:40 INFO - (blobuploader) - INFO - Done attempting. 09:25:40 INFO - (blobuploader) - INFO - Iteration through files over. 09:25:40 INFO - Return code: 0 09:25:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:25:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:25:40 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/07d541ae124bd9272e8550a128442ec82d328b65fa3c979ca2e7f0023d93c9f98c30cdc1d8b285810d54c60a0d647cfd661f939c9013035a4b9e5b117aad8543", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/ab7b3651cde0bc24520d7ae465bafd8852c56e34814fddf53747dcd2f75200e86790094616b47d73639c67de115ca1dce16d0c5f7e2ec24162da8ae2f06281e0", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/60cd35164e74b8538003be7c1ace2facaad75f6e48054bc7ae90b0b41b0d037b2092022ac2acf927514cb1ec16626a0b7a64aba5786195f8568e91658941b55c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a714039108d8c2e15b654d67752eef0339753275e6ce8611cb656798f7f6e79d38de2fbeb3ef7876e8c66106baa45f22effedaee4a9b187228a076975b081006"} 09:25:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:25:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:25:40 INFO - Contents: 09:25:40 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/07d541ae124bd9272e8550a128442ec82d328b65fa3c979ca2e7f0023d93c9f98c30cdc1d8b285810d54c60a0d647cfd661f939c9013035a4b9e5b117aad8543", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/ab7b3651cde0bc24520d7ae465bafd8852c56e34814fddf53747dcd2f75200e86790094616b47d73639c67de115ca1dce16d0c5f7e2ec24162da8ae2f06281e0", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/60cd35164e74b8538003be7c1ace2facaad75f6e48054bc7ae90b0b41b0d037b2092022ac2acf927514cb1ec16626a0b7a64aba5786195f8568e91658941b55c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a714039108d8c2e15b654d67752eef0339753275e6ce8611cb656798f7f6e79d38de2fbeb3ef7876e8c66106baa45f22effedaee4a9b187228a076975b081006"} 09:25:40 INFO - Running post-run listener: copy_logs_to_upload_dir 09:25:40 INFO - Copying logs to upload dir... 09:25:40 INFO - mkdir: /builds/slave/test/build/upload/logs 09:25:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.932500 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-17 09:25:40.005797) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-17 09:25:40.010818) ========= 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=523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/07d541ae124bd9272e8550a128442ec82d328b65fa3c979ca2e7f0023d93c9f98c30cdc1d8b285810d54c60a0d647cfd661f939c9013035a4b9e5b117aad8543", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/ab7b3651cde0bc24520d7ae465bafd8852c56e34814fddf53747dcd2f75200e86790094616b47d73639c67de115ca1dce16d0c5f7e2ec24162da8ae2f06281e0", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/60cd35164e74b8538003be7c1ace2facaad75f6e48054bc7ae90b0b41b0d037b2092022ac2acf927514cb1ec16626a0b7a64aba5786195f8568e91658941b55c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a714039108d8c2e15b654d67752eef0339753275e6ce8611cb656798f7f6e79d38de2fbeb3ef7876e8c66106baa45f22effedaee4a9b187228a076975b081006"} build_url:https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011258 build_url: 'https://queue.taskcluster.net/v1/task/fRCJqJSeSlOS11TkaBvsyw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/07d541ae124bd9272e8550a128442ec82d328b65fa3c979ca2e7f0023d93c9f98c30cdc1d8b285810d54c60a0d647cfd661f939c9013035a4b9e5b117aad8543", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/ab7b3651cde0bc24520d7ae465bafd8852c56e34814fddf53747dcd2f75200e86790094616b47d73639c67de115ca1dce16d0c5f7e2ec24162da8ae2f06281e0", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/60cd35164e74b8538003be7c1ace2facaad75f6e48054bc7ae90b0b41b0d037b2092022ac2acf927514cb1ec16626a0b7a64aba5786195f8568e91658941b55c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/a714039108d8c2e15b654d67752eef0339753275e6ce8611cb656798f7f6e79d38de2fbeb3ef7876e8c66106baa45f22effedaee4a9b187228a076975b081006"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-17 09:25:40.038569) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 09:25:40.038917) ========= 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=523ca41ca1e0623de333ad52000001bf-1487351099.9996-719502799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004470 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-17 09:25:40.119104) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-17 09:25:40.122451) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-17 09:25:40.122766) ========= ========= Total master_lag: 0.21 =========