builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-035 starttime: 1482037408.76 results: success (0) buildid: 20161217201335 builduid: 5254cd2c71bc4d61b517aa2f5eab8c91 revision: a3ce1fce4f15616f66ac328e4a562d0117c93a0d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-17 21:03:28.764075) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-17 21:03:28.764533) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-17 21:03:28.764806) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-17 21:03:28.776796) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:03:28.777171) ========= 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=ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-17 21:03:29-- 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.5M=0s 2016-12-17 21:03:29 (45.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.168777 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:03:28.958150) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:03:28.958464) ========= 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=ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017938 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:03:29.012108) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:03:29.012416) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a3ce1fce4f15616f66ac328e4a562d0117c93a0d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev a3ce1fce4f15616f66ac328e4a562d0117c93a0d --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=ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-17 21:03:29,380 truncating revision to first 12 chars 2016-12-17 21:03:29,380 Setting DEBUG logging. 2016-12-17 21:03:29,380 attempt 1/10 2016-12-17 21:03:29,380 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a3ce1fce4f15?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-17 21:03:29,707 unpacking tar archive at: mozilla-central-a3ce1fce4f15/testing/mozharness/ program finished with exit code 0 elapsedTime=0.622965 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:03:29.648731) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-17 21:03:29.649051) ========= script_repo_revision: a3ce1fce4f15616f66ac328e4a562d0117c93a0d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-17 21:03:29.649445) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-17 21:03:29.649707) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-17 21:03:29.659885) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-12-17 21:03:29.660284) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:03:30 INFO - MultiFileLogger online at 20161217 21:03:30 in /builds/slave/test 21:03:30 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 21:03:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:03:30 INFO - {'append_to_log': False, 21:03:30 INFO - 'base_work_dir': '/builds/slave/test', 21:03:30 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 21:03:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:03:30 INFO - 'branch': 'Firefox-Non-PGO', 21:03:30 INFO - 'buildbot_json_path': 'buildprops.json', 21:03:30 INFO - 'config_files': ('talos/linux_config.py',), 21:03:30 INFO - 'default_actions': ('clobber', 21:03:30 INFO - 'read-buildbot-config', 21:03:30 INFO - 'download-and-extract', 21:03:30 INFO - 'populate-webroot', 21:03:30 INFO - 'create-virtualenv', 21:03:30 INFO - 'install', 21:03:30 INFO - 'run-tests'), 21:03:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:03:30 INFO - 'download_minidump_stackwalk': True, 21:03:30 INFO - 'download_symbols': 'ondemand', 21:03:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:03:30 INFO - 'tooltool.py': '/tools/tooltool.py', 21:03:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:03:30 INFO - '/tools/misc-python/virtualenv.py')}, 21:03:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:03:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:03:30 INFO - 'installer_path': 'installer.exe', 21:03:30 INFO - 'log_level': 'info', 21:03:30 INFO - 'log_name': 'talos', 21:03:30 INFO - 'log_to_console': True, 21:03:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:03:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:03:30 INFO - 'opt_config_files': (), 21:03:30 INFO - 'pip_index': False, 21:03:30 INFO - 'sps_profile': False, 21:03:30 INFO - 'sps_profile_interval': 0, 21:03:30 INFO - 'suite': 'dromaeojs', 21:03:30 INFO - 'system_bits': '32', 21:03:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:03:30 INFO - 'title': 'talos-linux64-ix-035', 21:03:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:03:30 INFO - 'use_talos_json': True, 21:03:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:03:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:03:30 INFO - 'work_dir': 'build'} 21:03:30 INFO - [mozharness: 2016-12-18 05:03:30.128099Z] Running clobber step. 21:03:30 INFO - Running pre-action listener: _resource_record_pre_action 21:03:30 INFO - Running main action method: clobber 21:03:30 INFO - rmtree: /builds/slave/test/build 21:03:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:03:31 INFO - Running post-action listener: _resource_record_post_action 21:03:31 INFO - [mozharness: 2016-12-18 05:03:31.089136Z] Finished clobber step (success) 21:03:31 INFO - [mozharness: 2016-12-18 05:03:31.089237Z] Running read-buildbot-config step. 21:03:31 INFO - Running pre-action listener: _resource_record_pre_action 21:03:31 INFO - Running main action method: read_buildbot_config 21:03:31 INFO - Using buildbot properties: 21:03:31 INFO - { 21:03:31 INFO - "project": "", 21:03:31 INFO - "product": "firefox", 21:03:31 INFO - "script_repo_revision": "production", 21:03:31 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 21:03:31 INFO - "repository": "", 21:03:31 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 21:03:31 INFO - "buildid": "20161217201335", 21:03:31 INFO - "pgo_build": "False", 21:03:31 INFO - "basedir": "/builds/slave/test", 21:03:31 INFO - "buildnumber": 879, 21:03:31 INFO - "slavename": "talos-linux64-ix-035", 21:03:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:03:31 INFO - "platform": "ubuntu64_hw", 21:03:31 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 21:03:31 INFO - "branch": "mozilla-central", 21:03:31 INFO - "repo_path": "mozilla-central", 21:03:31 INFO - "revision": "a3ce1fce4f15616f66ac328e4a562d0117c93a0d", 21:03:31 INFO - "stage_platform": "linux64", 21:03:31 INFO - "builduid": "5254cd2c71bc4d61b517aa2f5eab8c91", 21:03:31 INFO - "slavebuilddir": "test" 21:03:31 INFO - } 21:03:31 INFO - Found installer url https://queue.taskcluster.net/v1/task/IgiTXn4yQn6GvXkzVrguDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2. 21:03:31 INFO - Running post-action listener: _resource_record_post_action 21:03:31 INFO - [mozharness: 2016-12-18 05:03:31.091675Z] Finished read-buildbot-config step (success) 21:03:31 INFO - [mozharness: 2016-12-18 05:03:31.091763Z] Running download-and-extract step. 21:03:31 INFO - Running pre-action listener: _resource_record_pre_action 21:03:31 INFO - Running main action method: download_and_extract 21:03:31 INFO - mkdir: /builds/slave/test/build/tests 21:03:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:31 INFO - trying https://queue.taskcluster.net/v1/task/IgiTXn4yQn6GvXkzVrguDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 21:03:31 INFO - Downloading https://queue.taskcluster.net/v1/task/IgiTXn4yQn6GvXkzVrguDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 21:03:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IgiTXn4yQn6GvXkzVrguDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:03:31 INFO - Downloaded 1361 bytes. 21:03:31 INFO - Reading from file /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.test_packages.json 21:03:31 INFO - Using the following test package requirements: 21:03:31 INFO - {u'common': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 21:03:31 INFO - u'cppunittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:03:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:03:31 INFO - u'gtest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:03:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:03:31 INFO - u'jittest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:03:31 INFO - u'jsshell-linux-x86_64.zip'], 21:03:31 INFO - u'mochitest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:03:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:03:31 INFO - u'mozbase': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'], 21:03:31 INFO - u'reftest': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:03:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:03:31 INFO - u'talos': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:03:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:03:31 INFO - u'web-platform': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:03:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:03:31 INFO - u'xpcshell': [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', 21:03:31 INFO - u'firefox-53.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:03:31 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:03:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IgiTXn4yQn6GvXkzVrguDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 21:03:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IgiTXn4yQn6GvXkzVrguDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:03:31 INFO - Fetch https://queue.taskcluster.net/v1/task/IgiTXn4yQn6GvXkzVrguDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:03:32 INFO - Expected file size: 20257475 21:03:32 INFO - Obtained file size: 20257475 21:03:36 INFO - Downloading packages: [u'firefox-53.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:03:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IgiTXn4yQn6GvXkzVrguDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip 21:03:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IgiTXn4yQn6GvXkzVrguDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:03:36 INFO - Fetch https://queue.taskcluster.net/v1/task/IgiTXn4yQn6GvXkzVrguDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:03:37 INFO - Expected file size: 20257475 21:03:37 INFO - Obtained file size: 20257475 21:03:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IgiTXn4yQn6GvXkzVrguDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip 21:03:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IgiTXn4yQn6GvXkzVrguDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:03:42 INFO - Fetch https://queue.taskcluster.net/v1/task/IgiTXn4yQn6GvXkzVrguDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:03:44 INFO - Expected file size: 14409734 21:03:44 INFO - Obtained file size: 14409734 21:03:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:44 INFO - trying https://queue.taskcluster.net/v1/task/IgiTXn4yQn6GvXkzVrguDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 21:03:44 INFO - Downloading https://queue.taskcluster.net/v1/task/IgiTXn4yQn6GvXkzVrguDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 21:03:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IgiTXn4yQn6GvXkzVrguDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:03:47 INFO - Downloaded 55641770 bytes. 21:03:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IgiTXn4yQn6GvXkzVrguDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 21:03:47 INFO - mkdir: /builds/slave/test/properties 21:03:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:03:47 INFO - Writing to file /builds/slave/test/properties/build_url 21:03:47 INFO - Contents: 21:03:47 INFO - build_url:https://queue.taskcluster.net/v1/task/IgiTXn4yQn6GvXkzVrguDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 21:03:48 INFO - Running post-action listener: _resource_record_post_action 21:03:48 INFO - Running post-action listener: set_extra_try_arguments 21:03:48 INFO - [mozharness: 2016-12-18 05:03:48.176023Z] Finished download-and-extract step (success) 21:03:48 INFO - [mozharness: 2016-12-18 05:03:48.176250Z] Running populate-webroot step. 21:03:48 INFO - Running pre-action listener: _resource_record_pre_action 21:03:48 INFO - Running main action method: populate_webroot 21:03:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:03:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:03:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:03:48 INFO - '--tppagecycles', 21:03:48 INFO - '7'], 21:03:48 INFO - 'tests': ['tsvgm']}}, 21:03:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:03:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:03:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:03:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:03:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:03:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:03:48 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:03:48 INFO - 'talos_options': ['--disable-e10s'], 21:03:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:03:48 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:03:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:03:48 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:03:48 INFO - 'talos_options': ['--disable-e10s'], 21:03:48 INFO - 'tests': ['damp', 'tps']}, 21:03:48 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:03:48 INFO - 'tests': ['damp', 'tps']}, 21:03:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:03:48 INFO - 'tests': ['dromaeo_dom']}, 21:03:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:03:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:03:48 INFO - 'tests': ['basic_compositor_video']}, 21:03:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:03:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:03:48 INFO - 'tests': ['a11yr', 21:03:48 INFO - 'ts_paint', 21:03:48 INFO - 'tpaint', 21:03:48 INFO - 'sessionrestore', 21:03:48 INFO - 'sessionrestore_no_auto_restore', 21:03:48 INFO - 'tabpaint']}, 21:03:48 INFO - 'other-e10s': {'tests': ['a11yr', 21:03:48 INFO - 'ts_paint', 21:03:48 INFO - 'tpaint', 21:03:48 INFO - 'sessionrestore', 21:03:48 INFO - 'sessionrestore_no_auto_restore', 21:03:48 INFO - 'tabpaint']}, 21:03:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:03:48 INFO - 'ts_paint', 21:03:48 INFO - 'tpaint', 21:03:48 INFO - 'sessionrestore', 21:03:48 INFO - 'sessionrestore_no_auto_restore', 21:03:48 INFO - 'tabpaint']}, 21:03:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:03:48 INFO - 'ts_paint', 21:03:48 INFO - 'tpaint', 21:03:48 INFO - 'sessionrestore', 21:03:48 INFO - 'sessionrestore_no_auto_restore', 21:03:48 INFO - 'tabpaint']}, 21:03:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:03:48 INFO - 'tests': ['a11yr', 21:03:48 INFO - 'ts_paint', 21:03:48 INFO - 'tpaint', 21:03:48 INFO - 'sessionrestore', 21:03:48 INFO - 'sessionrestore_no_auto_restore', 21:03:48 INFO - 'tabpaint']}, 21:03:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:03:48 INFO - 'tests': ['a11yr', 21:03:48 INFO - 'ts_paint', 21:03:48 INFO - 'tpaint', 21:03:48 INFO - 'sessionrestore', 21:03:48 INFO - 'sessionrestore_no_auto_restore', 21:03:48 INFO - 'tabpaint']}, 21:03:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:03:48 INFO - 'tests': ['tsvgx', 21:03:48 INFO - 'tsvgr_opacity', 21:03:48 INFO - 'tart', 21:03:48 INFO - 'tscrollx', 21:03:48 INFO - 'cart', 21:03:48 INFO - 'tsvg_static']}, 21:03:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:03:48 INFO - 'tsvgr_opacity', 21:03:48 INFO - 'tart', 21:03:48 INFO - 'tscrollx', 21:03:48 INFO - 'cart', 21:03:48 INFO - 'tsvg_static']}, 21:03:48 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:03:48 INFO - 'talos_options': ['--disable-e10s'], 21:03:48 INFO - 'tests': ['tp5o']}, 21:03:48 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:03:48 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:03:48 INFO - 'talos_options': ['--disable-e10s', 21:03:48 INFO - '--xperf_path', 21:03:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:03:48 INFO - 'tests': ['tp5n']}, 21:03:48 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:03:48 INFO - 'talos_options': ['--xperf_path', 21:03:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:03:48 INFO - 'tests': ['tp5n']}}, 21:03:48 INFO - 'talos.zip': {'path': '', 21:03:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:03:48 INFO - Running post-action listener: _resource_record_post_action 21:03:48 INFO - [mozharness: 2016-12-18 05:03:48.193625Z] Finished populate-webroot step (success) 21:03:48 INFO - [mozharness: 2016-12-18 05:03:48.193713Z] Running create-virtualenv step. 21:03:48 INFO - Running pre-action listener: _resource_record_pre_action 21:03:48 INFO - Running main action method: create_virtualenv 21:03:48 INFO - Creating virtualenv /builds/slave/test/build/venv 21:03:48 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:03:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:03:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:03:48 INFO - Using real prefix '/usr' 21:03:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:03:48 INFO - Installing distribute.............................................................................................................................................................................................done. 21:03:50 INFO - Installing pip.................done. 21:03:50 INFO - Return code: 0 21:03:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:03:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:03:50 INFO - Reading from file tmpfile_stdout 21:03:50 INFO - Output received: 21:03:50 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) 21:03:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:50 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 0xfb41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1326630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13af850>, '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 0x13246d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1324b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824', '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 21:03:50 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 21:03:50 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 21:03:50 INFO - Using env: {'DISPLAY': ':0', 21:03:50 INFO - 'HOME': '/home/cltbld', 21:03:50 INFO - 'LANG': 'en_US.UTF-8', 21:03:51 INFO - 'LANGUAGE': 'en_US:en', 21:03:51 INFO - 'LOGNAME': 'cltbld', 21:03:51 INFO - 'MAIL': '/var/mail/cltbld', 21:03:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:51 INFO - 'MOZ_NO_REMOTE': '1', 21:03:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:51 INFO - 'NO_EM_RESTART': '1', 21:03:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:51 INFO - 'PWD': '/builds/slave/test', 21:03:51 INFO - 'SHELL': '/bin/bash', 21:03:51 INFO - 'SHLVL': '1', 21:03:51 INFO - 'TERM': 'linux', 21:03:51 INFO - 'TMOUT': '86400', 21:03:51 INFO - 'USER': 'cltbld', 21:03:51 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824', 21:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:51 INFO - '_': '/tools/buildbot/bin/python'} 21:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:03:51 INFO - Cleaning up... 21:03:51 INFO - Return code: 0 21:03:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1326630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13af850>, '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 0x13246d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1324b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824', '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 21:03:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:03:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:03:51 INFO - Using env: {'DISPLAY': ':0', 21:03:51 INFO - 'HOME': '/home/cltbld', 21:03:51 INFO - 'LANG': 'en_US.UTF-8', 21:03:51 INFO - 'LANGUAGE': 'en_US:en', 21:03:51 INFO - 'LOGNAME': 'cltbld', 21:03:51 INFO - 'MAIL': '/var/mail/cltbld', 21:03:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:51 INFO - 'MOZ_NO_REMOTE': '1', 21:03:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:51 INFO - 'NO_EM_RESTART': '1', 21:03:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:51 INFO - 'PWD': '/builds/slave/test', 21:03:51 INFO - 'SHELL': '/bin/bash', 21:03:51 INFO - 'SHLVL': '1', 21:03:51 INFO - 'TERM': 'linux', 21:03:51 INFO - 'TMOUT': '86400', 21:03:51 INFO - 'USER': 'cltbld', 21:03:51 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824', 21:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:51 INFO - '_': '/tools/buildbot/bin/python'} 21:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:51 INFO - Downloading/unpacking psutil>=3.1.1 21:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:03:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:03:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:03:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:03:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:03:53 INFO - Installing collected packages: psutil 21:03:53 INFO - Running setup.py install for psutil 21:03:53 INFO - building 'psutil._psutil_linux' extension 21:03:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:03:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:03:53 INFO - building 'psutil._psutil_posix' extension 21:03:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:03:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:03:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:03:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:03:54 INFO - Successfully installed psutil 21:03:54 INFO - Cleaning up... 21:03:54 INFO - Return code: 0 21:03:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1326630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13af850>, '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 0x13246d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1324b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824', '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 21:03:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:03:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:03:54 INFO - Using env: {'DISPLAY': ':0', 21:03:54 INFO - 'HOME': '/home/cltbld', 21:03:54 INFO - 'LANG': 'en_US.UTF-8', 21:03:54 INFO - 'LANGUAGE': 'en_US:en', 21:03:54 INFO - 'LOGNAME': 'cltbld', 21:03:54 INFO - 'MAIL': '/var/mail/cltbld', 21:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:54 INFO - 'MOZ_NO_REMOTE': '1', 21:03:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:54 INFO - 'NO_EM_RESTART': '1', 21:03:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:54 INFO - 'PWD': '/builds/slave/test', 21:03:54 INFO - 'SHELL': '/bin/bash', 21:03:54 INFO - 'SHLVL': '1', 21:03:54 INFO - 'TERM': 'linux', 21:03:54 INFO - 'TMOUT': '86400', 21:03:54 INFO - 'USER': 'cltbld', 21:03:54 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824', 21:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:54 INFO - '_': '/tools/buildbot/bin/python'} 21:03:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:03:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:03:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:03:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:03:56 INFO - Installing collected packages: mozsystemmonitor 21:03:56 INFO - Running setup.py install for mozsystemmonitor 21:03:56 INFO - Successfully installed mozsystemmonitor 21:03:56 INFO - Cleaning up... 21:03:56 INFO - Return code: 0 21:03:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1326630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13af850>, '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 0x13246d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1324b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824', '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 21:03:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:03:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:03:56 INFO - Using env: {'DISPLAY': ':0', 21:03:56 INFO - 'HOME': '/home/cltbld', 21:03:56 INFO - 'LANG': 'en_US.UTF-8', 21:03:56 INFO - 'LANGUAGE': 'en_US:en', 21:03:56 INFO - 'LOGNAME': 'cltbld', 21:03:56 INFO - 'MAIL': '/var/mail/cltbld', 21:03:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:56 INFO - 'MOZ_NO_REMOTE': '1', 21:03:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:56 INFO - 'NO_EM_RESTART': '1', 21:03:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:56 INFO - 'PWD': '/builds/slave/test', 21:03:56 INFO - 'SHELL': '/bin/bash', 21:03:56 INFO - 'SHLVL': '1', 21:03:56 INFO - 'TERM': 'linux', 21:03:56 INFO - 'TMOUT': '86400', 21:03:56 INFO - 'USER': 'cltbld', 21:03:56 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824', 21:03:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:56 INFO - '_': '/tools/buildbot/bin/python'} 21:03:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:56 INFO - Downloading/unpacking jsonschema==2.5.1 21:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:03:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:03:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:03:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:03:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:58 INFO - Downloading functools32-3.2.3-2.tar.gz 21:03:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:03:58 INFO - warning: no files found matching '*.txt' 21:03:58 INFO - no previously-included directories found matching 'build' 21:03:58 INFO - no previously-included directories found matching 'dist' 21:03:58 INFO - no previously-included directories found matching '.git*' 21:03:58 INFO - Installing collected packages: jsonschema, functools32 21:03:58 INFO - Running setup.py install for functools32 21:03:59 INFO - warning: no files found matching '*.txt' 21:03:59 INFO - no previously-included directories found matching 'build' 21:03:59 INFO - no previously-included directories found matching 'dist' 21:03:59 INFO - no previously-included directories found matching '.git*' 21:03:59 INFO - Successfully installed jsonschema functools32 21:03:59 INFO - Cleaning up... 21:03:59 INFO - Return code: 0 21:03:59 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1326630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13af850>, '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 0x13246d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1324b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824', '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 21:03:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:03:59 INFO - Using env: {'DISPLAY': ':0', 21:03:59 INFO - 'HOME': '/home/cltbld', 21:03:59 INFO - 'LANG': 'en_US.UTF-8', 21:03:59 INFO - 'LANGUAGE': 'en_US:en', 21:03:59 INFO - 'LOGNAME': 'cltbld', 21:03:59 INFO - 'MAIL': '/var/mail/cltbld', 21:03:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:59 INFO - 'MOZ_NO_REMOTE': '1', 21:03:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:59 INFO - 'NO_EM_RESTART': '1', 21:03:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:59 INFO - 'PWD': '/builds/slave/test', 21:03:59 INFO - 'SHELL': '/bin/bash', 21:03:59 INFO - 'SHLVL': '1', 21:03:59 INFO - 'TERM': 'linux', 21:03:59 INFO - 'TMOUT': '86400', 21:03:59 INFO - 'USER': 'cltbld', 21:03:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824', 21:03:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:59 INFO - '_': '/tools/buildbot/bin/python'} 21:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:03:59 INFO - Cleaning up... 21:03:59 INFO - Return code: 0 21:03:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1326630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13af850>, '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 0x13246d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1324b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824', '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 21:03:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:03:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:03:59 INFO - Using env: {'DISPLAY': ':0', 21:03:59 INFO - 'HOME': '/home/cltbld', 21:03:59 INFO - 'LANG': 'en_US.UTF-8', 21:03:59 INFO - 'LANGUAGE': 'en_US:en', 21:03:59 INFO - 'LOGNAME': 'cltbld', 21:03:59 INFO - 'MAIL': '/var/mail/cltbld', 21:03:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:59 INFO - 'MOZ_NO_REMOTE': '1', 21:03:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:03:59 INFO - 'NO_EM_RESTART': '1', 21:03:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:03:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:59 INFO - 'PWD': '/builds/slave/test', 21:03:59 INFO - 'SHELL': '/bin/bash', 21:03:59 INFO - 'SHLVL': '1', 21:03:59 INFO - 'TERM': 'linux', 21:03:59 INFO - 'TMOUT': '86400', 21:03:59 INFO - 'USER': 'cltbld', 21:03:59 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824', 21:03:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:59 INFO - '_': '/tools/buildbot/bin/python'} 21:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:59 INFO - Downloading/unpacking blobuploader==1.2.4 21:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:03:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:03:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:03:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:03:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:01 INFO - Downloading blobuploader-1.2.4.tar.gz 21:04:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:04:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:04:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:04:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:04:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:04:02 INFO - Downloading docopt-0.6.1.tar.gz 21:04:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:04:02 INFO - Installing collected packages: blobuploader, requests, docopt 21:04:02 INFO - Running setup.py install for blobuploader 21:04:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:04:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:04:02 INFO - Running setup.py install for requests 21:04:03 INFO - Running setup.py install for docopt 21:04:03 INFO - Successfully installed blobuploader requests docopt 21:04:03 INFO - Cleaning up... 21:04:03 INFO - Return code: 0 21:04:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:04:03 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')]} 21:04:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:03 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')]} 21:04:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:03 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 0xfb41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1326630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13af850>, '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 0x13246d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1324b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824', '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 21:04:03 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 21:04:03 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 21:04:03 INFO - Using env: {'DISPLAY': ':0', 21:04:03 INFO - 'HOME': '/home/cltbld', 21:04:03 INFO - 'LANG': 'en_US.UTF-8', 21:04:03 INFO - 'LANGUAGE': 'en_US:en', 21:04:03 INFO - 'LOGNAME': 'cltbld', 21:04:03 INFO - 'MAIL': '/var/mail/cltbld', 21:04:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:03 INFO - 'MOZ_NO_REMOTE': '1', 21:04:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:03 INFO - 'NO_EM_RESTART': '1', 21:04:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:03 INFO - 'PWD': '/builds/slave/test', 21:04:03 INFO - 'SHELL': '/bin/bash', 21:04:03 INFO - 'SHLVL': '1', 21:04:03 INFO - 'TERM': 'linux', 21:04:03 INFO - 'TMOUT': '86400', 21:04:03 INFO - 'USER': 'cltbld', 21:04:03 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824', 21:04:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:03 INFO - '_': '/tools/buildbot/bin/python'} 21:04:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:04:03 INFO - Running setup.py (path:/tmp/pip-GnUlHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:04:03 INFO - Running setup.py (path:/tmp/pip-zXT9k4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:04:03 INFO - Running setup.py (path:/tmp/pip-iB0Rm1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:04:03 INFO - Running setup.py (path:/tmp/pip-AQ4s0X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:04:03 INFO - Running setup.py (path:/tmp/pip-OV1hL2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:04:03 INFO - Running setup.py (path:/tmp/pip-baTchP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:04:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:04:03 INFO - Running setup.py (path:/tmp/pip-SZ389h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:04:04 INFO - Running setup.py (path:/tmp/pip-bQtcxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:04:04 INFO - Running setup.py (path:/tmp/pip-uZPbgt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:04:04 INFO - Running setup.py (path:/tmp/pip-cwpGEk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:04:04 INFO - Running setup.py (path:/tmp/pip-wI0geV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:04:04 INFO - Running setup.py (path:/tmp/pip-1iMtjN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:04:04 INFO - Running setup.py (path:/tmp/pip-zsJw9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:04:04 INFO - Running setup.py (path:/tmp/pip-IwbwgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:04:04 INFO - Running setup.py (path:/tmp/pip-Kan5Ia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:04:04 INFO - Running setup.py (path:/tmp/pip-wW0f1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:04:04 INFO - Running setup.py (path:/tmp/pip-KO00U_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:04:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:04:04 INFO - Running setup.py install for manifestparser 21:04:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:04:04 INFO - Running setup.py install for mozcrash 21:04:04 INFO - Running setup.py install for mozdebug 21:04:05 INFO - Running setup.py install for mozdevice 21:04:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:04:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:04:05 INFO - Running setup.py install for mozfile 21:04:05 INFO - Running setup.py install for mozhttpd 21:04:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:04:05 INFO - Running setup.py install for mozinfo 21:04:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:04:05 INFO - Running setup.py install for mozInstall 21:04:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:04:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:04:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:04:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:04:05 INFO - Running setup.py install for mozleak 21:04:05 INFO - Running setup.py install for mozlog 21:04:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:04:05 INFO - Running setup.py install for moznetwork 21:04:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:04:05 INFO - Running setup.py install for mozprocess 21:04:05 INFO - Running setup.py install for mozprofile 21:04:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:04:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:04:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:04:06 INFO - Running setup.py install for mozrunner 21:04:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:04:06 INFO - Running setup.py install for mozscreenshot 21:04:06 INFO - Running setup.py install for moztest 21:04:06 INFO - Running setup.py install for mozversion 21:04:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:04:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:04:06 INFO - Cleaning up... 21:04:06 INFO - Return code: 0 21:04:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:04: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')]} 21:04:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04: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')]} 21:04:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1326630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13af850>, '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 0x13246d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1324b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824', '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 21:04:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:04:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:04:06 INFO - Using env: {'DISPLAY': ':0', 21:04:06 INFO - 'HOME': '/home/cltbld', 21:04:06 INFO - 'LANG': 'en_US.UTF-8', 21:04:06 INFO - 'LANGUAGE': 'en_US:en', 21:04:06 INFO - 'LOGNAME': 'cltbld', 21:04:06 INFO - 'MAIL': '/var/mail/cltbld', 21:04:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:06 INFO - 'MOZ_NO_REMOTE': '1', 21:04:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:06 INFO - 'NO_EM_RESTART': '1', 21:04:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:06 INFO - 'PWD': '/builds/slave/test', 21:04:06 INFO - 'SHELL': '/bin/bash', 21:04:06 INFO - 'SHLVL': '1', 21:04:06 INFO - 'TERM': 'linux', 21:04:06 INFO - 'TMOUT': '86400', 21:04:06 INFO - 'USER': 'cltbld', 21:04:06 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824', 21:04:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:06 INFO - '_': '/tools/buildbot/bin/python'} 21:04:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:04:06 INFO - Running setup.py (path:/tmp/pip-wpG72c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:04:06 INFO - Running setup.py (path:/tmp/pip-cwoL7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:04:06 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)) 21:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:04:06 INFO - Running setup.py (path:/tmp/pip-Yh7nSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:04:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:04:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:04:07 INFO - Running setup.py (path:/tmp/pip-fEKeVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:04:07 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)) 21:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:04:07 INFO - Running setup.py (path:/tmp/pip-myGn5J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:04:07 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)) 21:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:04:07 INFO - Running setup.py (path:/tmp/pip-zRxE9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:04:07 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)) 21:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:04:07 INFO - Running setup.py (path:/tmp/pip-QwG5UE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:04:07 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)) 21:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:04:07 INFO - Running setup.py (path:/tmp/pip-pXsPLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:04:07 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)) 21:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:04:07 INFO - Running setup.py (path:/tmp/pip-CmTPIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:04:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:04:07 INFO - Running setup.py (path:/tmp/pip-7eHTFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:04:07 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)) 21:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:04:07 INFO - Running setup.py (path:/tmp/pip-L1ujyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:04:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:04:07 INFO - Running setup.py (path:/tmp/pip-cvfJ1Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:04:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:04:07 INFO - Running setup.py (path:/tmp/pip-_4pg6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:04:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:04:07 INFO - Running setup.py (path:/tmp/pip-x7DdmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:04:07 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)) 21:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:04:07 INFO - Running setup.py (path:/tmp/pip-5uA3zA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:04:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:04:07 INFO - Running setup.py (path:/tmp/pip-3bUWVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:04:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:04:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:04:07 INFO - Running setup.py (path:/tmp/pip-JGmpLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:04:08 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)) 21:04:08 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)) 21:04:08 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)) 21:04:08 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)) 21:04:08 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)) 21:04:08 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)) 21:04:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:04:08 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 21:04:08 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 21:04:08 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 21:04:08 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 21:04:08 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 21:04:08 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 21:04:09 INFO - Downloading blessings-1.6.tar.gz 21:04:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:04:10 INFO - Installing collected packages: blessings 21:04:10 INFO - Running setup.py install for blessings 21:04:10 INFO - Successfully installed blessings 21:04:10 INFO - Cleaning up... 21:04:10 INFO - Return code: 0 21:04:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:04:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:04:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:04:10 INFO - Reading from file tmpfile_stdout 21:04:10 INFO - Current package versions: 21:04:10 INFO - argparse == 1.2.1 21:04:10 INFO - blessings == 1.6 21:04:10 INFO - blobuploader == 1.2.4 21:04:10 INFO - docopt == 0.6.1 21:04:10 INFO - functools32 == 3.2.3-2 21:04:10 INFO - jsonschema == 2.5.1 21:04:10 INFO - manifestparser == 1.1 21:04:10 INFO - mozInstall == 1.12 21:04:10 INFO - mozcrash == 1.0 21:04:10 INFO - mozdebug == 0.1 21:04:10 INFO - mozdevice == 0.49 21:04:10 INFO - mozfile == 1.2 21:04:10 INFO - mozhttpd == 0.7 21:04:10 INFO - mozinfo == 0.9 21:04:10 INFO - mozleak == 0.1 21:04:10 INFO - mozlog == 3.4 21:04:10 INFO - moznetwork == 0.27 21:04:10 INFO - mozprocess == 0.23 21:04:10 INFO - mozprofile == 0.28 21:04:10 INFO - mozrunner == 6.13 21:04:10 INFO - mozscreenshot == 0.1 21:04:10 INFO - mozsystemmonitor == 0.3 21:04:10 INFO - moztest == 0.7 21:04:10 INFO - mozversion == 1.4 21:04:10 INFO - psutil == 3.1.1 21:04:10 INFO - requests == 1.2.3 21:04:10 INFO - wsgiref == 0.1.2 21:04:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:10 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 0xfb41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1326630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13af850>, '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 0x13246d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1324b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824', '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 21:04:10 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 21:04:10 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 21:04:10 INFO - Using env: {'DISPLAY': ':0', 21:04:10 INFO - 'HOME': '/home/cltbld', 21:04:10 INFO - 'LANG': 'en_US.UTF-8', 21:04:10 INFO - 'LANGUAGE': 'en_US:en', 21:04:10 INFO - 'LOGNAME': 'cltbld', 21:04:10 INFO - 'MAIL': '/var/mail/cltbld', 21:04:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:10 INFO - 'MOZ_NO_REMOTE': '1', 21:04:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:10 INFO - 'NO_EM_RESTART': '1', 21:04:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:10 INFO - 'PWD': '/builds/slave/test', 21:04:10 INFO - 'SHELL': '/bin/bash', 21:04:10 INFO - 'SHLVL': '1', 21:04:10 INFO - 'TERM': 'linux', 21:04:10 INFO - 'TMOUT': '86400', 21:04:10 INFO - 'USER': 'cltbld', 21:04:10 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824', 21:04:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:10 INFO - '_': '/tools/buildbot/bin/python'} 21:04:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:04:10 INFO - Cleaning up... 21:04:10 INFO - Return code: 0 21:04:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:04:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:04:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:04:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:04:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xfb41f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1326630>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13af850>, '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 0x13246d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1324b60>, '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': 'ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824', '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 21:04:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:04:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:04:10 INFO - Using env: {'DISPLAY': ':0', 21:04:10 INFO - 'HOME': '/home/cltbld', 21:04:10 INFO - 'LANG': 'en_US.UTF-8', 21:04:10 INFO - 'LANGUAGE': 'en_US:en', 21:04:10 INFO - 'LOGNAME': 'cltbld', 21:04:10 INFO - 'MAIL': '/var/mail/cltbld', 21:04:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:10 INFO - 'MOZ_NO_REMOTE': '1', 21:04:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:10 INFO - 'NO_EM_RESTART': '1', 21:04:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:10 INFO - 'PWD': '/builds/slave/test', 21:04:10 INFO - 'SHELL': '/bin/bash', 21:04:10 INFO - 'SHLVL': '1', 21:04:10 INFO - 'TERM': 'linux', 21:04:10 INFO - 'TMOUT': '86400', 21:04:10 INFO - 'USER': 'cltbld', 21:04:10 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824', 21:04:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:10 INFO - '_': '/tools/buildbot/bin/python'} 21:04:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:04:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:04:10 INFO - Cleaning up... 21:04:10 INFO - Return code: 0 21:04:10 INFO - Running post-action listener: _resource_record_post_action 21:04:10 INFO - Running post-action listener: _start_resource_monitoring 21:04:10 INFO - Starting resource monitoring. 21:04:10 INFO - [mozharness: 2016-12-18 05:04:10.949734Z] Finished create-virtualenv step (success) 21:04:10 INFO - [mozharness: 2016-12-18 05:04:10.950257Z] Running install step. 21:04:10 INFO - Running pre-action listener: _resource_record_pre_action 21:04:10 INFO - Running main action method: install 21:04:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:04:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:04:11 INFO - Reading from file tmpfile_stdout 21:04:11 INFO - Detecting whether we're running mozinstall >=1.0... 21:04:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:04:11 INFO - Reading from file tmpfile_stdout 21:04:11 INFO - Output received: 21:04:11 INFO - Usage: mozinstall [options] installer 21:04:11 INFO - Options: 21:04:11 INFO - -h, --help show this help message and exit 21:04:11 INFO - -d DEST, --destination=DEST 21:04:11 INFO - Directory to install application into. [default: 21:04:11 INFO - "/builds/slave/test"] 21:04:11 INFO - --app=APP Application being installed. [default: firefox] 21:04:11 INFO - mkdir: /builds/slave/test/build/application 21:04:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:04:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:04:27 INFO - Reading from file tmpfile_stdout 21:04:27 INFO - Output received: 21:04:27 INFO - /builds/slave/test/build/application/firefox/firefox 21:04:27 INFO - Running post-action listener: _resource_record_post_action 21:04:27 INFO - [mozharness: 2016-12-18 05:04:27.288369Z] Finished install step (success) 21:04:27 INFO - [mozharness: 2016-12-18 05:04:27.288616Z] Running run-tests step. 21:04:27 INFO - Running pre-action listener: _resource_record_pre_action 21:04:27 INFO - Running main action method: run_tests 21:04:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:04:27 INFO - Python 2.7.3 21:04:27 INFO - Return code: 0 21:04:27 INFO - grabbing minidump binary from tooltool 21:04: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')]} 21:04:27 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 0x13af850>, '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 0x13246d0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1324b60>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:04:27 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 21:04:27 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 21:04:27 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 21:04:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:04:27 INFO - Return code: 0 21:04:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:04:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:04:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:04:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:04:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:04:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IgiTXn4yQn6GvXkzVrguDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 21:04:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IgiTXn4yQn6GvXkzVrguDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 21:04:27 INFO - Using env: {'DISPLAY': ':0', 21:04:27 INFO - 'HOME': '/home/cltbld', 21:04:27 INFO - 'LANG': 'en_US.UTF-8', 21:04:27 INFO - 'LANGUAGE': 'en_US:en', 21:04:27 INFO - 'LOGNAME': 'cltbld', 21:04:27 INFO - 'MAIL': '/var/mail/cltbld', 21:04:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:04:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:04:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:04:27 INFO - 'MOZ_NO_REMOTE': '1', 21:04:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:04:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:04:27 INFO - 'NO_EM_RESTART': '1', 21:04:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:04:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:04:27 INFO - 'PWD': '/builds/slave/test', 21:04:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:04:27 INFO - 'SHELL': '/bin/bash', 21:04:27 INFO - 'SHLVL': '1', 21:04:27 INFO - 'TERM': 'linux', 21:04:27 INFO - 'TMOUT': '86400', 21:04:27 INFO - 'USER': 'cltbld', 21:04:27 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824', 21:04:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:04:27 INFO - '_': '/tools/buildbot/bin/python'} 21:04:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IgiTXn4yQn6GvXkzVrguDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 21:04:27 INFO - mozversion application_buildid: 20161217201335 21:04:27 INFO - mozversion application_changeset: a3ce1fce4f15616f66ac328e4a562d0117c93a0d 21:04:27 INFO - mozversion application_display_name: Nightly 21:04:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:04:27 INFO - mozversion application_name: Firefox 21:04:27 INFO - mozversion application_remotingname: firefox 21:04:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:04:27 INFO - mozversion application_vendor: Mozilla 21:04:27 INFO - mozversion application_version: 53.0a1 21:04:27 INFO - mozversion platform_buildid: 20161217201335 21:04:27 INFO - mozversion platform_changeset: a3ce1fce4f15616f66ac328e4a562d0117c93a0d 21:04:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:04:27 INFO - mozversion platform_version: 53.0a1 21:04:27 INFO - using testdate: 1482037467 21:04:27 INFO - actual date: 1482037467 21:04:27 INFO - starting webserver on 'localhost:46484' 21:04:27 INFO - SUITE-START | Running 2 tests 21:04:27 INFO - TEST-START | dromaeo_css 21:04:27 INFO - operating with platform_type : linux_ 21:04:27 INFO - Initialising browser for dromaeo_css test... 21:04:27 INFO - TEST-INFO | started process 18684 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDukR2O/profile http://localhost:46484/getInfo.html) 21:04:31 INFO - PROCESS | 18684 | __metrics Screen width/height:1600/1200 21:04:31 INFO - PROCESS | 18684 | colorDepth:24 21:04:31 INFO - PROCESS | 18684 | Browser inner width/height: 1024/697 21:04:31 INFO - PROCESS | 18684 | __metrics 21:04:32 INFO - PROCESS | 18684 | 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" 21:04:32 INFO - PROCESS | 18684 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:04:32 INFO - PROCESS | 18684 | console.error: PushService: 21:04:32 INFO - PROCESS | 18684 | stateChangeProcessEnqueue: Error transitioning state 21:04:32 INFO - PROCESS | 18684 | UnknownError 21:04:33 INFO - TEST-INFO | 18684: exit 0 21:04:33 INFO - Browser initialized. 21:04:33 INFO - Running cycle 1/1 for dromaeo_css test... 21:04:33 INFO - TEST-INFO | started process 18765 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDukR2O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:04:45 INFO - PROCESS | 18765 | RSS: Main: 155545600 21:04:45 INFO - PROCESS | 18765 | 21:05:36 INFO - PROCESS | 18765 | 1482037536064 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 21:07:49 INFO - PROCESS | 18765 | Cycle 1(1): loaded http://localhost:46484/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46484/tests/dromaeo/cssquery-ext.html) 21:07:51 INFO - PROCESS | 18765 | RSS: Main: 216944640 21:07:51 INFO - PROCESS | 18765 | 21:10:54 INFO - PROCESS | 18765 | Cycle 1(1): loaded http://localhost:46484/tests/dromaeo/cssquery-ext.html (next: http://localhost:46484/tests/dromaeo/cssquery-jquery.html) 21:10:55 INFO - PROCESS | 18765 | RSS: Main: 246063104 21:10:55 INFO - PROCESS | 18765 | 21:13:57 INFO - PROCESS | 18765 | Cycle 1(1): loaded http://localhost:46484/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46484/tests/dromaeo/cssquery-mootools.html) 21:13:58 INFO - PROCESS | 18765 | RSS: Main: 184774656 21:13:58 INFO - PROCESS | 18765 | 21:17:00 INFO - PROCESS | 18765 | Cycle 1(1): loaded http://localhost:46484/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46484/tests/dromaeo/cssquery-prototype.html) 21:17:00 INFO - PROCESS | 18765 | RSS: Main: 186966016 21:17:00 INFO - PROCESS | 18765 | 21:20:04 INFO - PROCESS | 18765 | Cycle 1(1): loaded http://localhost:46484/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46484/tests/dromaeo/cssquery-yui.html) 21:20:04 INFO - PROCESS | 18765 | RSS: Main: 186712064 21:20:04 INFO - PROCESS | 18765 | 21:23:07 INFO - PROCESS | 18765 | Cycle 1(1): loaded http://localhost:46484/tests/dromaeo/cssquery-yui.html (next: http://localhost:46484/tests/dromaeo/cssquery-dojo.html) 21:23:07 INFO - PROCESS | 18765 | RSS: Main: 284254208 21:23:07 INFO - PROCESS | 18765 | 21:23:07 INFO - PROCESS | 18765 | __start_tp_report 21:23:07 INFO - PROCESS | 18765 | _x_x_mozilla_page_load 21:23:07 INFO - PROCESS | 18765 | _x_x_mozilla_page_load_details 21:23:07 INFO - PROCESS | 18765 | |i|pagename|runs| 21:23:07 INFO - PROCESS | 18765 | |0;dojo.html;2573.420980279437;2600.973990260097;2616.960745588816;2636.419987602727;2645.7089720130784;4615.28463088221;4646.25659894417;4688.976555117224;4693.2256177730715;4705.10602985433;4713.905721885569;4717.952820471794;4739.668223224376;4784.5693887550115;4822.252550854614;4263.062126332202;4291.763952982585;4345.348197770328;4371.606555410012;4460.8661740147845;3922.627350401707;4349.69552131351;4360.084382279725;4403.141387429452;4431.6233120184825;4393.934090988638;4451.955480445203;4465.196264672358;4467.262901621229;4472.396226509429;4227.661787057028;4269.252880745857;4276.166147601219;4312.439382880237;4339.7830108494445;4335.479742430928;4351.086271882877;4379.583939525772;4390.846320378803;4414.073044660625;4701;4702.952970470285;4725.621950243973;4755.096531659008;4799.520047995207;4922.507749225085;4967.304577359173;4967.7019378837385;5085.389753229636;5097.286379906816;5045.4197767256865;5056.115179843513;5076.695398276078;5108.897822043576;5149.794008239666;4758.455783865305;4760.619150468024;4762.4285085789925;4764.6426518011285;4808.0383923215495;4909.361782968192;5218.321618189611;5228.241904923841;5236.73816309183;5280.841574752763;4777.689450185727;4836.177849765478;4937.308776771255;4966.205407134841;4969.478204788517;5072.82245121419;5077.568406685473;5079.31429257053;5081.2378143278065;5112.156494178494;4991.401031876198;5028.547430731252;5036.546710796046;5068.391792984866;5087.847364579068;4873.220284754422;4926.211806111005;4931.950680493149;4932.062908047459;4952.851414457572;4324.372965919924;4353.194658988034;4360.41134446852;4393.340998850134;4404.2512772828695;3786.734928554975;3787.6780473660046;3792.981035094862;3807.8286477108595;3826.0243637872163;4200.5169405518145;4234.343676730112;4347.673924455678;4354.9564504355185;4380.69335146543;4994;5005.224190250517;5026.447090820006;5046.571041461517;5094.923576146361;4329.6969212154845;4341.435613370241;4342.34864770287;4343.348497725303;4377.649788016951;4488.236999710057;4576.6109880660515;4578.290364993365;4581.060882519076;4619.792109355087;4629.513901040342;4705.5059218781535;4733.384659994179;4755.952440475551;4771.045790841776;5134.15286477727;5155.896882062413;5161.948380516147;5163.535281824654;5190.870228244324;4798.352222449925;4798.7840547174765;4799.712017278975;4803.639727020418;4833.9274910875665;4849.660523763303;4863.562279394871;4883.633727470383;4905.141600219876;5103.642745007963;4957.801687932442;4969.726665033458;5005.34930459038;5015.598752099896;5051.747412629427;5004.599632029502;5037.269595908646;5042.042012017705;5048.0156369507595;5076.543111120017;4765.833195838268;4797.136515427256;4865.7323847188745;5040.49595040493;5048.470288633209;4777.713337199779;4847.781849816696;4852.927206091841;4871.415430148405;4895.241237608177;4773.856784296477;4930.260460930889;4955.35580374549;4972.701637901738;4983.725895075806;4653.953460465487;4768.928466072943;4849.2726091086615;4854.660173787801;4903.8528844134735 21:23:07 INFO - PROCESS | 18765 | |1;ext.html;502.37705245495584;538.1282322637328;542.3193891665958;543.128279112025;554.7669978608986;36576.268474630524;37457.625423745754;37469.437958430644;37501.437478437845;37530.99999999996;37567.43648845263;38100.23799524008;38127.23745525088;38129.42805857914;38170;7385;7463.552186868778;7632.885506717404;7633.618319084051;7637.350825179867;7397.742383794768;9600.231981441468;9819.754506137333;9824.803503929917;10154.949225253864;9911.851322230137;9964.352317099401;9974.800503989916;9980.800383992315;9984.900150998506;9783.559739811726;9836.704898853046;9842.212622990215;9843.557039933221;9851.556679949384;9625.374350667184;9686.32195746298;9687.225021998223;9695.90304096957;9699.51502424883;36571.63428365709;36825.26349472995;36863.81568092169;36892.63107368919;36901.446478302845;2860.7997440179197;2873.6407949006375;3016.909492715222;3031.5301128325145;3251.0734440684528;26928.192154235403;27365.726342736714;27541.86229068862;27668;28295.292617684518;3354.1279267390655;3429.4855771634207;3433.5536380270655;3442.1566716154452;3443.1220038889924;239063.80468097722;239837;239901;240102;240313;48840.7557962215;49162.508374916506;49175.75412122916;49260.26109608359;49272.75363623159;50435;50526;50554;50585.74707126514;50587.49412505901;13655;13818.447262109403;13840.93079534596;13849.307534623229;13865.37605807741;10012.299139060342;10301;10410.063094321547;10670.199735019905;10671.413072281099;14359.138451692932;14897.702045959237;14959.177245251398;15013.174275414738;15223.259813233724;5511.476409741068;5549.972250138723;5699.800506982236;5737.627054241461;5788.88422231553;738.623302115914;759.7910574591921;801.6993627389729;819.0989911097745;924.9676261330821;24760.752392475846;26196.08313709011;26698.5995210072;26706.465870682867;26728.465430691667;931.3247895275871;945.8486642137225;951.6003278622995;998.3610489286863;1002.9268682509645;12758.298293593756;13747.862521374658;14035.78946315806;14039.438422462987;14059.718805624036;331389;336365;336661;336946;336990;48657;48700.26949595688;48721.269180962314;48725.37108974642;48832.26751598729;1031.3657100882904;1077.2190162132547;1085.2077983072559;1129.0515966588105;1137.4824454873012;25620.743792561836;27190.01819599685;27446.588301175896;29899.850500747358;30452.086437406913;45271;45957.31064034109;45988.54011459843;46024;46024.76987615041;301131;303689;303813;305440;305460;21580.46048848791;21950;22168;23523.059077636703;23926.282211533682;35265.29469410649;38990.610093899835;39034.6096539031;39600.811975640776;39630.80184599059;32977.67022329746;33114.66885331116;33147.83426082854;33248.83375583107;33783.83108084444;32038;32509;32789.508157378135;33375.666243337255;33853;32858.835705822275;32895.83552082224;32950.34099318048;33005;33482.497762533094;27725.44549108966;29938.25154371071;30910.69089309168;31224.21939451532;31375;23965;24293.635595466436;24359.75640243575;24674.259772206864;24747.381315467257 21:23:07 INFO - PROCESS | 18765 | |2;jquery.html;356.59526437493435;360.7673050882181;363.5020022569081;369.9482072509851;377.5526001688;15199;15859.286332115054;16507.66984660306;16531;16542.338306467725;15686.13726245056;16572.254248558813;16659.416920407788;16753.748693769605;16762.07808570528;4831.3719216501895;4986.800527978877;5006.4492905780335;5016.724080175589;5017.473165317644;3713.8885833424906;3881.068543549556;4903.730294833783;4998.425181104165;5530.5852061095375;5846.181534585162;5861.765529378819;5866.618669786471;5868.119782032687;5874.588778785486;5664.150377443396;5738.282714660668;5768.567357448208;5773.797917072924;5851.356350801409;5067.366579177603;5072.9746351268;5073.137566613685;5074.264231686422;5075.086484432801;19342.709859352122;19693.21227150912;19890.602187956305;19900.70148947767;20055.6991645124;1852.3424184414473;1910.5414700471927;1935.554822390858;2065.5765568058514;2274.1699279762765;12159.878401215963;12716.364181790967;12784.488620455171;13505.86494135056;13564.525241616595;1710;1749.7462867884085;1781.1272476486558;1791.6237590106093;1796.9820301797076;61243.38756612421;61463.385366146664;62842;63236;63978.68010659963;9177.77055573616;9217.76955576116;9293.210077143518;9443.197328227177;9780.657676981271;13010.089293749535;13041.282729449782;13048.869511304765;13049.608511744664;13088.214707117604;6363.61818290904;6435.4529864962005;6497.902531462032;6527.640979746065;6553.803385898431;5761.193432919395;5761.8559536011935;5793.102069179284;5808.912866307009;5987.43119403656;5877.94122058774;5999.370066142992;6028.5478589106;6068.575199735976;6125.754969801158;1542.7608720648318;1648.777415048977;1668.8247733987998;1677.004364805877;1682;710.9751158709421;784.8430313937235;851.5699571716243;879.7360791762445;919.2186641354795;16189.352425902833;16883;17371.3051477942;17563.64872702539;17834.19746111428;809.9311558517475;859.9011113721876;869.8303830752942;878.1481962496368;891.6149300620814;9577.042295770507;9841.901580984242;9946;10032.247581431277;10060.74848128788;315687;336053;337346;337441;338938;63027;64817.67591162108;65162.022569661494;65631.67184164049;66423.66788166028;913.123401534521;952.3048174832411;962.0523784072683;982.2485798364257;988.3526290279879;13878.722425551634;14707;14735;14997.925010374878;15493.690126197638;34879.65120348764;35908.64091359053;36015.27969440649;36795.63204367922;37138.814305928296;43738.34392484179;45387;45668.314975276066;46578.53421465742;48832.51167488279;7626.54240745557;7650.6174691264105;7792.727254546064;7874.56689882062;7879.881801772864;7248.782536523912;8700.173483519056;9628.66299679508;11498.54005839757;11801.881981180079;6364.840878977878;9782.510874456106;9879.950600246953;9885.802283954137;9953.452560109263;10104.242181836245;10260.97390260968;10273.332233404804;10286.742831429274;10471.94764026175;10353.378797272188;10376.584936602452;10414.687559373231;10513.684589462327;11108.555657773599;7324.304191101837;7390.778276651709;7465.141508726349;7511.136219334847;7521.849563008818;9138.954305228432;9692.369995950241;10189.643362482277;10195.184385249311;10782.083522900328 21:23:07 INFO - PROCESS | 18765 | |3;mootools.html;1321.9867801321986;1333.9799903001453;1387.3964825300995;1609.6378314879162;1640.1471234957814;7057.082579264695;7423.257674232581;7423.517471364357;7426.220246874068;7432.256774322572;6472.611643301405;6716.966415167917;7029.261927497616;7238.059052323204;7264.96367518163;2143.2605751015876;2178.9782102178933;2191.4521369657587;2192.243675931801;2193.616117179495;2123.373604786592;2167.1223154622403;2182.1053368119074;2182.9563408731815;2185.694002839604;1813.7098064309714;1870.6819840627127;2065.648839697255;2157;2159.708439360682;2111.788821117884;2116.2698868890207;2123.522207503315;2129.318618042227;2136.7756385579523;2144.7962443567835;2160.6975023496725;2180.574787916357;2180.7928246816527;2188.9233876814396;7295.416366690652;7375.852482950365;7376.409887209064;7376.594287314196;7394.186639469654;4414.624756895636;4556.567126123046;4558.658100642465;4559.863204103849;4564.589186973155;2659.255408485627;2845.701201373867;2849.3873817129415;2852.1586132091084;2869.0962346860674;775.6121939030485;809.3969992355733;829.3448175940999;879.2702057292432;880.5509190312987;9894.109530142321;9931.255155863339;9973.301868869255;9985.301028927977;9985.500724963722;3928.9214215715524;4098.918021639551;4142.2543942090115;4205.705600607989;4233.04756429807;8590.14098590136;8600.39797214189;8614.095519970439;8616.956915215509;8622.482651040958;4499.752513611717;4537.478190008125;4579.06129243511;4582.427196600425;4585.105904348687;3986.80065996699;4144.91710165795;4154.50145982484;4160.105577300895;4191.057012172237;3327.351166522505;3354.966450335465;3389.6271410144864;3433.3305005524185;3444.3111377724053;1117.452448300327;1139.4302848575712;1159.47244003978;1163.627639155462;1164.6622479481025;564.2692712936757;621.5462712220015;768.9577073260913;801.939854510914;820.5856042698399;4871.756412179377;4924.901501969941;5026.648134630614;5102.566281866083;5138.845834624967;797.4338219863846;797.5453991225062;842.4945032980286;874.5976850648645;876.7983363826355;3331.900042998714;3381.4758712399616;3399.286149908547;3411.8123503207066;3586.55168103987;8603.698870539502;9047.502387368626;9068.773280667903;9076.319276054322;9080.545972701471;9008.549572521348;9029.097090290918;9032.051634578274;9034.096590341045;9046;6759.898601520981;6857.691403886737;6926.515143939876;6994.160700715946;7000.509964302551;4847.297141914332;4875.9512404875495;4916.345173606355;4944.307796908363;5027.899442011212;8146.14465481116;8160.224778646019;8233.917660823316;8237.093919668952;8242.752717418487;7621.1616722161625;7917.406194535318;7930.9603451982375;8147.470414423044;8369.246767790928;6298.307186209605;6431.967840160769;6448.838779030561;6448.967755161382;6455.515836312202;6956.304369563206;7002.334778196063;7026.156861176692;7026.2271150174465;7031.472639552157;6254.937450625435;6303.590266632654;6315.684215789101;6349.238091429058;6582.045603387578;6068.4841788448475;6181.660008699565;6316.778912738032;6375.7449702013255;6505.739770409131;5858.209141765978;6131.172291740736;6131.509479241561;6131.509479241739;6133.785317513865;4289.892752681208;4320.870373888788;4354.9782251088545;4379.233634114081;4423.203823311835;4392.626626736763;4474.597286244254;4493.797779099883;4529.909401812011;4556.134334476439 21:23:07 INFO - PROCESS | 18765 | |4;prototype.html;342.4606245163867;354.7711725936771;357.85864583489524;360.77631868241696;363.75083068098354;4848.060775689726;4852.902941941159;4857.392825896763;4884.560389564938;4908.558229759321;4834.34736310598;4851;4865.683730557511;4873.610111191105;4881.5118488151165;3637.5271214742047;3713.3501637213517;3774.8867533974026;3838.445429601002;3889.941650875225;3887.1448281378052;3897.532296124469;3920.1571662092642;3933.5476420211758;3939.881803545884;3804.8097595120134;3861.4014827701753;3870.542205699373;3870.9225815483674;3902.2780785554623;3679.374506333916;3765.7740535567955;3773.2642134783728;3828.770273783568;3842.654161125512;3439.2949445363643;3453.5855697316483;3474.1835668617855;3476.4263896457055;3492.2491664292297;4623.942345656184;4640.419947506562;4640.976795116037;4651.976740116312;4681.74250416227;4305.182015417061;4394.8461803837035;4429.512753597101;4442.888927776799;4445.53321901199;4978.452370239271;5020.3724534433195;5025.0954828130925;5027.974860125712;5038;3762.6425489578446;3804.90487737806;3812.1803812180515;3814.1608846053823;3818.350880350319;5066.898662026812;5254.448282930313;5261.842144735664;5285.841424757264;5308.734563271821;3862.3627101528496;3872.9225415491533;3884.5921178275876;3886.9222615548097;3890.455336252927;3910.7066969976795;3933.665638420709;3933.7412028150716;3943.7633741975;3947.3289540778137;4393.538678438718;4406.030673251879;4408.911821763547;4412.977935110304;4414.602685758297;4945.530174633404;5011.398632164163;5017;5032.647714659939;5099.847004589794;1333.9132956357805;1340.6782372230593;1347.723716638087;1350.257358452847;1364.836219653648;950.1347708894853;975;979.7942432089341;980.2158273381267;990.6235630460523;4291.50647675515;4354.673399495051;4424.3142312941545;4465.129299786576;4511.819527218874;5187.948120518822;5194.68831870089;5209.4009188943;5214.843554693365;5224.738763061908;4452.30989196675;4458.598726114666;4476.328550717419;4478.888027799266;4490.7754612269255;2579.9871000644875;2672.492226476963;2682.771964383049;2691.8250313729545;2707.6750789905336;4699.418067384341;4709;4714.222153344728;4721.457032441244;4758.643101767381;5131.435542090367;5161.922571161435;5169.638125331191;5177.171652535576;5178.870528236749;4602;4868.221084626513;4892.828750993698;4902.656814022984;4921.434035086011;5210.5831533477985;5225.843224703113;5241.344831896013;5250.241169208358;5288.8413347599635;4931.876703082308;5151.330327057609;5171.612129090258;5174.602857228602;5183.796886323373;4884.072026314989;4914;4917.262410638433;4921.760598927551;4926.802927882844;3705.462233173203;3705.981470092632;3728.6830619397656;3735.5890852005714;3748.4564738112276;5108.233764935289;5280.287161233338;5281.392639846313;5284.603654725834;5306.602004849575;5104.821331253388;5124.154514505065;5126.564242039469;5137.561482784826;5153.845384638467;5104.846854594368;5106.7701953412925;5135.2553879687985;5158.587313014875;5159.561437277874;4813.470518243061;5056.7724452399;5064.721440320818;5068.518490743373;5086.880886205177;4924.310596516562;4977.502249774993;5021.246812977936;5128.58971282304;5141.940545375495;4971.160670551919;4980.975095124501;4985.5762260208285;5001.57486613642;5001.7749201285305 21:23:07 INFO - PROCESS | 18765 | |5;yui.html;609.9237595300588;648.1800522339239;677.8779819632467;706.7385067525016;719.2914978745938;14730.484433044845;15305.617359566017;15408.69182616347;15417.922910385447;15419.383224670999;14213.147211167312;14719.705605887875;14792.482263120794;14800.185989770558;14809.629759256024;604.7308947518334;758.8861670749391;780.8438312337527;781.4646966827713;782.5734974438944;626.1046703214402;747.872861613527;770.214381331042;774.2335088262607;781.1914668318292;814.3810703865075;818.2022528035178;819.1071731812324;819.8319344534386;819.942604017719;635.4757325206676;805.7179987004531;806.7378102116835;807.0396228488139;807.6284908941893;484.9490803465656;571.7455732199173;592.943670351316;593.2762030323042;596.8239369386041;12993.285369304684;13010.349482525837;13024.54414095502;13027.28349940753;13028.478860845555;11869.287842729464;12076.939615301868;12354.938225308815;12385.07111966597;12581.496740130475;11345.602903898323;11439.885601143966;11527.13546484017;11651.941740291244;11658.6502404928;3920.764754114734;3949.3483575210057;3977.6817854571855;3990.7206495545324;4004.8598299059686;49736.76184571703;62336.37663623351;64570;65527;65549;9817.361871478332;9917.404955702681;10122.848157277647;10125.443100629389;10167.898321016695;17757.911210443865;17828.732569011474;17828.821711782977;17843;17847.73228401575;6193.969030154821;6487.448566871774;6537.967310163419;6744.831379215559;6752.088468056848;3586.677199052098;3649.1606930405624;3654.543182102237;3659.798711070863;3689.2805902849223;2643.762061414482;2694.3533551947785;2705.4724328756097;2726.3865630233436;2745.052956729925;477.05781082362057;478.5406010230218;478.96304500755474;479.09451137350436;489.3418352316129;446.7386578851408;488.22372427839906;558.2101326622783;559.8012705489574;586.9148973398918;7363.374113200438;7945.761627151194;7996.04047514302;8081.555514446762;8123.431359804875;498.5338708307744;535.1063723581628;535.5661913849716;559.5439716630933;568.6815383385317;3446.7070299024863;3458.8097654629237;3502.754807163525;3507.7369197310304;3676.8345424455965;63662.36337636657;65053;66270.33729662737;67866;68009.65995169993;46498.5350146501;52476;57774.7111264441;58996;59237;52984.735076324374;53207.73396133072;53214.201786974;53656.46343536593;53904.46095538994;6535.509836762357;6764.0868482754195;6769.120014398097;6831.077804496329;6985.685644145924;37098.258034839695;37372;37533.249335013694;37866.43200351942;39251;45219;46464.767676161406;48883.75558122186;49165.508344916096;50239.49760502348;9002.954985225031;9124.726258212264;9156.313276504156;9332.486713230837;9413.388129771543;9721.368111072758;9840.803183936425;10157.339772914736;10442.791144176921;10637.27743250527;9673.903260967581;10278.17774578017;10471.790564188826;10477;10492.632757853438;10005.210530233366;10219.386836789816;10234.283600147919;10245.077942985166;10470.633527826489;9488.146066854017;9623.182029527568;9629.085236902483;9744;9832.164266037467;8186.345092392475;8399.244068033906;8821.735347939572;9004.189622933967;9023.548822558978;8211.096779354148;8293.377996650155;8503.277221436247;8528.658853645784;8597.570121493774 21:23:07 INFO - PROCESS | 18765 | __end_tp_report 21:23:07 INFO - PROCESS | 18765 | __start_cc_report 21:23:07 INFO - PROCESS | 18765 | _x_x_mozilla_cycle_collect,1755 21:23:07 INFO - PROCESS | 18765 | __end_cc_report 21:23:07 INFO - PROCESS | 18765 | __startTimestamp1482038587892__endTimestamp 21:23:07 INFO - PROCESS | 18765 | 21:23:07 INFO - PROCESS | 18765 | ------- Summary: start ------- 21:23:07 INFO - PROCESS | 18765 | Number of tests: 6 21:23:07 INFO - PROCESS | 18765 | 21:23:07 INFO - PROCESS | 18765 | [#0] dojo.html Cycles:165 Average:4668.70 Median:4784.57 stddev:489.23 (10.2%) stddev-sans-first:462.29 21:23:07 INFO - PROCESS | 18765 | Values: 2573.4 2601.0 2617.0 2636.4 2645.7 4615.3 4646.3 4689.0 4693.2 4705.1 4713.9 4718.0 4739.7 4784.6 4822.3 4263.1 4291.8 4345.3 4371.6 4460.9 3922.6 4349.7 4360.1 4403.1 4431.6 4393.9 4452.0 4465.2 4467.3 4472.4 4227.7 4269.3 4276.2 4312.4 4339.8 4335.5 4351.1 4379.6 4390.8 4414.1 4701.0 4703.0 4725.6 4755.1 4799.5 4922.5 4967.3 4967.7 5085.4 5097.3 5045.4 5056.1 5076.7 5108.9 5149.8 4758.5 4760.6 4762.4 4764.6 4808.0 4909.4 5218.3 5228.2 5236.7 5280.8 4777.7 4836.2 4937.3 4966.2 4969.5 5072.8 5077.6 5079.3 5081.2 5112.2 4991.4 5028.5 5036.5 5068.4 5087.8 4873.2 4926.2 4932.0 4932.1 4952.9 4324.4 4353.2 4360.4 4393.3 4404.3 3786.7 3787.7 3793.0 3807.8 3826.0 4200.5 4234.3 4347.7 4355.0 4380.7 4994.0 5005.2 5026.4 5046.6 5094.9 4329.7 4341.4 4342.3 4343.3 4377.6 4488.2 4576.6 4578.3 4581.1 4619.8 4629.5 4705.5 4733.4 4756.0 4771.0 5134.2 5155.9 5161.9 5163.5 5190.9 4798.4 4798.8 4799.7 4803.6 4833.9 4849.7 4863.6 4883.6 4905.1 5103.6 4957.8 4969.7 5005.3 5015.6 5051.7 5004.6 5037.3 5042.0 5048.0 5076.5 4765.8 4797.1 4865.7 5040.5 5048.5 4777.7 4847.8 4852.9 4871.4 4895.2 4773.9 4930.3 4955.4 4972.7 4983.7 4654.0 4768.9 4849.3 4854.7 4903.9 21:23:07 INFO - PROCESS | 18765 | 21:23:07 INFO - PROCESS | 18765 | [#1] ext.html Cycles:180 Average:44372.48 Median:185386.92 stddev:77596.05 (41.9%) stddev-sans-first:77743.82 21:23:07 INFO - PROCESS | 18765 | Values: 502.4 538.1 542.3 543.1 554.8 36576.3 37457.6 37469.4 37501.4 37531.0 37567.4 38100.2 38127.2 38129.4 38170.0 7385.0 7463.6 7632.9 7633.6 7637.4 7397.7 9600.2 9819.8 9824.8 10154.9 9911.9 9964.4 9974.8 9980.8 9984.9 9783.6 9836.7 9842.2 9843.6 9851.6 9625.4 9686.3 9687.2 9695.9 9699.5 36571.6 36825.3 36863.8 36892.6 36901.4 2860.8 2873.6 3016.9 3031.5 3251.1 26928.2 27365.7 27541.9 27668.0 28295.3 3354.1 3429.5 3433.6 3442.2 3443.1 239063.8 239837.0 239901.0 240102.0 240313.0 48840.8 49162.5 49175.8 49260.3 49272.8 50435.0 50526.0 50554.0 50585.7 50587.5 13655.0 13818.4 13840.9 13849.3 13865.4 10012.3 10301.0 10410.1 10670.2 10671.4 14359.1 14897.7 14959.2 15013.2 15223.3 5511.5 5550.0 5699.8 5737.6 5788.9 738.6 759.8 801.7 819.1 925.0 24760.8 26196.1 26698.6 26706.5 26728.5 931.3 945.8 951.6 998.4 1002.9 12758.3 13747.9 14035.8 14039.4 14059.7 331389.0 336365.0 336661.0 336946.0 336990.0 48657.0 48700.3 48721.3 48725.4 48832.3 1031.4 1077.2 1085.2 1129.1 1137.5 25620.7 27190.0 27446.6 29899.9 30452.1 45271.0 45957.3 45988.5 46024.0 46024.8 301131.0 303689.0 303813.0 305440.0 305460.0 21580.5 21950.0 22168.0 23523.1 23926.3 35265.3 38990.6 39034.6 39600.8 39630.8 32977.7 33114.7 33147.8 33248.8 33783.8 32038.0 32509.0 32789.5 33375.7 33853.0 32858.8 32895.8 32950.3 33005.0 33482.5 27725.4 29938.3 30910.7 31224.2 31375.0 23965.0 24293.6 24359.8 24674.3 24747.4 21:23:07 INFO - PROCESS | 18765 | 21:23:07 INFO - PROCESS | 18765 | [#2] jquery.html Cycles:180 Average:21956.95 Median:4945.27 stddev:54946.94 (1111.1%) stddev-sans-first:55077.14 21:23:07 INFO - PROCESS | 18765 | Values: 356.6 360.8 363.5 369.9 377.6 15199.0 15859.3 16507.7 16531.0 16542.3 15686.1 16572.3 16659.4 16753.7 16762.1 4831.4 4986.8 5006.4 5016.7 5017.5 3713.9 3881.1 4903.7 4998.4 5530.6 5846.2 5861.8 5866.6 5868.1 5874.6 5664.2 5738.3 5768.6 5773.8 5851.4 5067.4 5073.0 5073.1 5074.3 5075.1 19342.7 19693.2 19890.6 19900.7 20055.7 1852.3 1910.5 1935.6 2065.6 2274.2 12159.9 12716.4 12784.5 13505.9 13564.5 1710.0 1749.7 1781.1 1791.6 1797.0 61243.4 61463.4 62842.0 63236.0 63978.7 9177.8 9217.8 9293.2 9443.2 9780.7 13010.1 13041.3 13048.9 13049.6 13088.2 6363.6 6435.5 6497.9 6527.6 6553.8 5761.2 5761.9 5793.1 5808.9 5987.4 5877.9 5999.4 6028.5 6068.6 6125.8 1542.8 1648.8 1668.8 1677.0 1682.0 711.0 784.8 851.6 879.7 919.2 16189.4 16883.0 17371.3 17563.6 17834.2 809.9 859.9 869.8 878.1 891.6 9577.0 9841.9 9946.0 10032.2 10060.7 315687.0 336053.0 337346.0 337441.0 338938.0 63027.0 64817.7 65162.0 65631.7 66423.7 913.1 952.3 962.1 982.2 988.4 13878.7 14707.0 14735.0 14997.9 15493.7 34879.7 35908.6 36015.3 36795.6 37138.8 43738.3 45387.0 45668.3 46578.5 48832.5 7626.5 7650.6 7792.7 7874.6 7879.9 7248.8 8700.2 9628.7 11498.5 11801.9 6364.8 9782.5 9880.0 9885.8 9953.5 10104.2 10261.0 10273.3 10286.7 10471.9 10353.4 10376.6 10414.7 10513.7 11108.6 7324.3 7390.8 7465.1 7511.1 7521.8 9139.0 9692.4 10189.6 10195.2 10782.1 21:23:07 INFO - PROCESS | 18765 | 21:23:07 INFO - PROCESS | 18765 | [#3] mootools.html Cycles:180 Average:4857.92 Median:3211.24 stddev:2652.29 (82.6%) stddev-sans-first:2646.41 21:23:07 INFO - PROCESS | 18765 | Values: 1322.0 1334.0 1387.4 1609.6 1640.1 7057.1 7423.3 7423.5 7426.2 7432.3 6472.6 6717.0 7029.3 7238.1 7265.0 2143.3 2179.0 2191.5 2192.2 2193.6 2123.4 2167.1 2182.1 2183.0 2185.7 1813.7 1870.7 2065.6 2157.0 2159.7 2111.8 2116.3 2123.5 2129.3 2136.8 2144.8 2160.7 2180.6 2180.8 2188.9 7295.4 7375.9 7376.4 7376.6 7394.2 4414.6 4556.6 4558.7 4559.9 4564.6 2659.3 2845.7 2849.4 2852.2 2869.1 775.6 809.4 829.3 879.3 880.6 9894.1 9931.3 9973.3 9985.3 9985.5 3928.9 4098.9 4142.3 4205.7 4233.0 8590.1 8600.4 8614.1 8617.0 8622.5 4499.8 4537.5 4579.1 4582.4 4585.1 3986.8 4144.9 4154.5 4160.1 4191.1 3327.4 3355.0 3389.6 3433.3 3444.3 1117.5 1139.4 1159.5 1163.6 1164.7 564.3 621.5 769.0 801.9 820.6 4871.8 4924.9 5026.6 5102.6 5138.8 797.4 797.5 842.5 874.6 876.8 3331.9 3381.5 3399.3 3411.8 3586.6 8603.7 9047.5 9068.8 9076.3 9080.5 9008.5 9029.1 9032.1 9034.1 9046.0 6759.9 6857.7 6926.5 6994.2 7000.5 4847.3 4876.0 4916.3 4944.3 5027.9 8146.1 8160.2 8233.9 8237.1 8242.8 7621.2 7917.4 7931.0 8147.5 8369.2 6298.3 6432.0 6448.8 6449.0 6455.5 6956.3 7002.3 7026.2 7026.2 7031.5 6254.9 6303.6 6315.7 6349.2 6582.0 6068.5 6181.7 6316.8 6375.7 6505.7 5858.2 6131.2 6131.5 6131.5 6133.8 4289.9 4320.9 4355.0 4379.2 4423.2 4392.6 4474.6 4493.8 4529.9 4556.1 21:23:07 INFO - PROCESS | 18765 | 21:23:07 INFO - PROCESS | 18765 | [#4] prototype.html Cycles:180 Average:4238.67 Median:4786.06 stddev:1193.03 (24.9%) stddev-sans-first:1159.98 21:23:07 INFO - PROCESS | 18765 | Values: 342.5 354.8 357.9 360.8 363.8 4848.1 4852.9 4857.4 4884.6 4908.6 4834.3 4851.0 4865.7 4873.6 4881.5 3637.5 3713.4 3774.9 3838.4 3889.9 3887.1 3897.5 3920.2 3933.5 3939.9 3804.8 3861.4 3870.5 3870.9 3902.3 3679.4 3765.8 3773.3 3828.8 3842.7 3439.3 3453.6 3474.2 3476.4 3492.2 4623.9 4640.4 4641.0 4652.0 4681.7 4305.2 4394.8 4429.5 4442.9 4445.5 4978.5 5020.4 5025.1 5028.0 5038.0 3762.6 3804.9 3812.2 3814.2 3818.4 5066.9 5254.4 5261.8 5285.8 5308.7 3862.4 3872.9 3884.6 3886.9 3890.5 3910.7 3933.7 3933.7 3943.8 3947.3 4393.5 4406.0 4408.9 4413.0 4414.6 4945.5 5011.4 5017.0 5032.6 5099.8 1333.9 1340.7 1347.7 1350.3 1364.8 950.1 975.0 979.8 980.2 990.6 4291.5 4354.7 4424.3 4465.1 4511.8 5187.9 5194.7 5209.4 5214.8 5224.7 4452.3 4458.6 4476.3 4478.9 4490.8 2580.0 2672.5 2682.8 2691.8 2707.7 4699.4 4709.0 4714.2 4721.5 4758.6 5131.4 5161.9 5169.6 5177.2 5178.9 4602.0 4868.2 4892.8 4902.7 4921.4 5210.6 5225.8 5241.3 5250.2 5288.8 4931.9 5151.3 5171.6 5174.6 5183.8 4884.1 4914.0 4917.3 4921.8 4926.8 3705.5 3706.0 3728.7 3735.6 3748.5 5108.2 5280.3 5281.4 5284.6 5306.6 5104.8 5124.2 5126.6 5137.6 5153.8 5104.8 5106.8 5135.3 5158.6 5159.6 4813.5 5056.8 5064.7 5068.5 5086.9 4924.3 4977.5 5021.2 5128.6 5141.9 4971.2 4981.0 4985.6 5001.6 5001.8 21:23:07 INFO - PROCESS | 18765 | 21:23:07 INFO - PROCESS | 18765 | [#5] yui.html Cycles:180 Average:14557.57 Median:535.34 stddev:18592.48 (3473.0%) stddev-sans-first:18615.14 21:23:07 INFO - PROCESS | 18765 | Values: 609.9 648.2 677.9 706.7 719.3 14730.5 15305.6 15408.7 15417.9 15419.4 14213.1 14719.7 14792.5 14800.2 14809.6 604.7 758.9 780.8 781.5 782.6 626.1 747.9 770.2 774.2 781.2 814.4 818.2 819.1 819.8 819.9 635.5 805.7 806.7 807.0 807.6 484.9 571.7 592.9 593.3 596.8 12993.3 13010.3 13024.5 13027.3 13028.5 11869.3 12076.9 12354.9 12385.1 12581.5 11345.6 11439.9 11527.1 11651.9 11658.7 3920.8 3949.3 3977.7 3990.7 4004.9 49736.8 62336.4 64570.0 65527.0 65549.0 9817.4 9917.4 10122.8 10125.4 10167.9 17757.9 17828.7 17828.8 17843.0 17847.7 6194.0 6487.4 6538.0 6744.8 6752.1 3586.7 3649.2 3654.5 3659.8 3689.3 2643.8 2694.4 2705.5 2726.4 2745.1 477.1 478.5 479.0 479.1 489.3 446.7 488.2 558.2 559.8 586.9 7363.4 7945.8 7996.0 8081.6 8123.4 498.5 535.1 535.6 559.5 568.7 3446.7 3458.8 3502.8 3507.7 3676.8 63662.4 65053.0 66270.3 67866.0 68009.7 46498.5 52476.0 57774.7 58996.0 59237.0 52984.7 53207.7 53214.2 53656.5 53904.5 6535.5 6764.1 6769.1 6831.1 6985.7 37098.3 37372.0 37533.2 37866.4 39251.0 45219.0 46464.8 48883.8 49165.5 50239.5 9003.0 9124.7 9156.3 9332.5 9413.4 9721.4 9840.8 10157.3 10442.8 10637.3 9673.9 10278.2 10471.8 10477.0 10492.6 10005.2 10219.4 10234.3 10245.1 10470.6 9488.1 9623.2 9629.1 9744.0 9832.2 8186.3 8399.2 8821.7 9004.2 9023.5 8211.1 8293.4 8503.3 8528.7 8597.6 21:23:07 INFO - PROCESS | 18765 | -------- Summary: end -------- 21:23:07 INFO - PROCESS | 18765 | 21:23:08 INFO - TEST-INFO | 18765: exit 0 21:23:08 INFO - TEST-OK | dromaeo_css | took 1121178ms 21:23:08 INFO - TEST-START | kraken 21:23:08 INFO - operating with platform_type : linux_ 21:23:08 INFO - Initialising browser for kraken test... 21:23:08 INFO - TEST-INFO | started process 19069 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGSL7r0/profile http://localhost:46484/getInfo.html) 21:23:12 INFO - PROCESS | 19069 | __metrics Screen width/height:1600/1200 21:23:12 INFO - PROCESS | 19069 | colorDepth:24 21:23:12 INFO - PROCESS | 19069 | Browser inner width/height: 1024/697 21:23:12 INFO - PROCESS | 19069 | __metrics 21:23:13 INFO - PROCESS | 19069 | 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" 21:23:13 INFO - PROCESS | 19069 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:23:13 INFO - PROCESS | 19069 | console.error: PushService: 21:23:13 INFO - PROCESS | 19069 | stateChangeProcessEnqueue: Error transitioning state 21:23:13 INFO - PROCESS | 19069 | UnknownError 21:23:14 INFO - TEST-INFO | 19069: exit 0 21:23:14 INFO - Browser initialized. 21:23:14 INFO - Running cycle 1/1 for kraken test... 21:23:14 INFO - TEST-INFO | started process 19152 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGSL7r0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:23:26 INFO - PROCESS | 19152 | RSS: Main: 156172288 21:23:26 INFO - PROCESS | 19152 | 21:23:29 INFO - PROCESS | 19152 | Cycle 1(1): loaded http://localhost:46484/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46484/tests/kraken/driver.html?testName=audio-beat-detection) 21:23:30 INFO - PROCESS | 19152 | RSS: Main: 210505728 21:23:30 INFO - PROCESS | 19152 | 21:23:32 INFO - PROCESS | 19152 | Cycle 1(1): loaded http://localhost:46484/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46484/tests/kraken/driver.html?testName=audio-dft) 21:23:33 INFO - PROCESS | 19152 | RSS: Main: 188035072 21:23:33 INFO - PROCESS | 19152 | 21:23:36 INFO - PROCESS | 19152 | Cycle 1(1): loaded http://localhost:46484/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46484/tests/kraken/driver.html?testName=audio-fft) 21:23:37 INFO - PROCESS | 19152 | RSS: Main: 270458880 21:23:37 INFO - PROCESS | 19152 | 21:23:39 INFO - PROCESS | 19152 | Cycle 1(1): loaded http://localhost:46484/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46484/tests/kraken/driver.html?testName=audio-oscillator) 21:23:40 INFO - PROCESS | 19152 | RSS: Main: 181538816 21:23:40 INFO - PROCESS | 19152 | 21:23:42 INFO - PROCESS | 19152 | Cycle 1(1): loaded http://localhost:46484/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46484/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:23:43 INFO - PROCESS | 19152 | RSS: Main: 185012224 21:23:43 INFO - PROCESS | 19152 | 21:23:46 INFO - PROCESS | 19152 | Cycle 1(1): loaded http://localhost:46484/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46484/tests/kraken/driver.html?testName=imaging-darkroom) 21:23:46 INFO - PROCESS | 19152 | RSS: Main: 224100352 21:23:46 INFO - PROCESS | 19152 | 21:23:50 INFO - PROCESS | 19152 | Cycle 1(1): loaded http://localhost:46484/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46484/tests/kraken/driver.html?testName=imaging-desaturate) 21:23:50 INFO - PROCESS | 19152 | RSS: Main: 223776768 21:23:50 INFO - PROCESS | 19152 | 21:23:53 INFO - PROCESS | 19152 | Cycle 1(1): loaded http://localhost:46484/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46484/tests/kraken/driver.html?testName=json-parse-financial) 21:23:54 INFO - PROCESS | 19152 | RSS: Main: 223014912 21:23:54 INFO - PROCESS | 19152 | 21:23:56 INFO - PROCESS | 19152 | Cycle 1(1): loaded http://localhost:46484/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46484/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:23:56 INFO - PROCESS | 19152 | RSS: Main: 185098240 21:23:56 INFO - PROCESS | 19152 | 21:23:58 INFO - PROCESS | 19152 | Cycle 1(1): loaded http://localhost:46484/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46484/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:23:59 INFO - PROCESS | 19152 | RSS: Main: 192241664 21:23:59 INFO - PROCESS | 19152 | 21:24:01 INFO - PROCESS | 19152 | Cycle 1(1): loaded http://localhost:46484/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46484/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:24:02 INFO - PROCESS | 19152 | RSS: Main: 200544256 21:24:02 INFO - PROCESS | 19152 | 21:24:04 INFO - PROCESS | 19152 | Cycle 1(1): loaded http://localhost:46484/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46484/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:24:05 INFO - PROCESS | 19152 | RSS: Main: 210083840 21:24:05 INFO - PROCESS | 19152 | 21:24:08 INFO - PROCESS | 19152 | Cycle 1(1): loaded http://localhost:46484/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46484/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:24:09 INFO - PROCESS | 19152 | RSS: Main: 206417920 21:24:09 INFO - PROCESS | 19152 | 21:24:11 INFO - PROCESS | 19152 | Cycle 1(1): loaded http://localhost:46484/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46484/tests/kraken/driver.html?testName=ai-astar) 21:24:11 INFO - PROCESS | 19152 | RSS: Main: 258424832 21:24:11 INFO - PROCESS | 19152 | 21:24:11 INFO - PROCESS | 19152 | __start_tp_report 21:24:11 INFO - PROCESS | 19152 | _x_x_mozilla_page_load 21:24:11 INFO - PROCESS | 19152 | _x_x_mozilla_page_load_details 21:24:11 INFO - PROCESS | 19152 | |i|pagename|runs| 21:24:11 INFO - PROCESS | 19152 | |0;ai-astar;113;117;116;114;114;115;114;114;115;114 21:24:11 INFO - PROCESS | 19152 | |1;audio-beat-detection;148;135;123;156;127;127;132;124;153;128 21:24:11 INFO - PROCESS | 19152 | |2;audio-dft;162;163;162;162;161;161;161;161;162;160 21:24:11 INFO - PROCESS | 19152 | |3;audio-fft;74;75;75;114;76;78;78;76;99;75 21:24:11 INFO - PROCESS | 19152 | |4;audio-oscillator;85;90;118;84;84;85;107;85;83;118 21:24:11 INFO - PROCESS | 19152 | |5;imaging-gaussian-blur;126;127;127;127;127;127;127;126;127;127 21:24:11 INFO - PROCESS | 19152 | |6;imaging-darkroom;147;146;147;146;147;147;147;147;147;147 21:24:11 INFO - PROCESS | 19152 | |7;imaging-desaturate;96;96;95;95;96;96;95;95;95;96 21:24:11 INFO - PROCESS | 19152 | |8;json-parse-financial;64;63;75;63;65;65;63;65;64;64 21:24:11 INFO - PROCESS | 19152 | |9;json-stringify-tinderbox;67;67;67;66;75;66;66;67;67;66 21:24:11 INFO - PROCESS | 19152 | |10;stanford-crypto-aes;88;85;86;85;85;85;85;90;85;84 21:24:11 INFO - PROCESS | 19152 | |11;stanford-crypto-ccm;141;146;134;135;137;140;134;133;188;134 21:24:11 INFO - PROCESS | 19152 | |12;stanford-crypto-pbkdf2;188;182;183;183;183;185;183;181;183;186 21:24:11 INFO - PROCESS | 19152 | |13;stanford-crypto-sha256-iterative;74;68;73;69;69;74;68;69;68;67 21:24:11 INFO - PROCESS | 19152 | __end_tp_report 21:24:11 INFO - PROCESS | 19152 | __start_cc_report 21:24:11 INFO - PROCESS | 19152 | _x_x_mozilla_cycle_collect,1949 21:24:11 INFO - PROCESS | 19152 | __end_cc_report 21:24:11 INFO - PROCESS | 19152 | __startTimestamp1482038651503__endTimestamp 21:24:11 INFO - PROCESS | 19152 | 21:24:11 INFO - PROCESS | 19152 | ------- Summary: start ------- 21:24:11 INFO - PROCESS | 19152 | Number of tests: 14 21:24:11 INFO - PROCESS | 19152 | 21:24:11 INFO - PROCESS | 19152 | [#0] ai-astar Cycles:10 Average:114.60 Median:114.50 stddev:1.17 (1.0%) stddev-sans-first:1.09 21:24:11 INFO - PROCESS | 19152 | Values: 113.0 117.0 116.0 114.0 114.0 115.0 114.0 114.0 115.0 114.0 21:24:11 INFO - PROCESS | 19152 | 21:24:11 INFO - PROCESS | 19152 | [#1] audio-beat-detection Cycles:10 Average:135.30 Median:133.50 stddev:12.40 (9.3%) stddev-sans-first:12.27 21:24:11 INFO - PROCESS | 19152 | Values: 148.0 135.0 123.0 156.0 127.0 127.0 132.0 124.0 153.0 128.0 21:24:11 INFO - PROCESS | 19152 | 21:24:11 INFO - PROCESS | 19152 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:0.85 (0.5%) stddev-sans-first:0.88 21:24:11 INFO - PROCESS | 19152 | Values: 162.0 163.0 162.0 162.0 161.0 161.0 161.0 161.0 162.0 160.0 21:24:11 INFO - PROCESS | 19152 | 21:24:11 INFO - PROCESS | 19152 | [#3] audio-fft Cycles:10 Average:82.00 Median:76.00 stddev:13.45 (17.7%) stddev-sans-first:13.95 21:24:11 INFO - PROCESS | 19152 | Values: 74.0 75.0 75.0 114.0 76.0 78.0 78.0 76.0 99.0 75.0 21:24:11 INFO - PROCESS | 19152 | 21:24:11 INFO - PROCESS | 19152 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:84.50 stddev:14.53 (17.2%) stddev-sans-first:15.05 21:24:11 INFO - PROCESS | 19152 | Values: 85.0 90.0 118.0 84.0 84.0 85.0 107.0 85.0 83.0 118.0 21:24:11 INFO - PROCESS | 19152 | 21:24:11 INFO - PROCESS | 19152 | [#5] imaging-gaussian-blur Cycles:10 Average:126.80 Median:127.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 21:24:11 INFO - PROCESS | 19152 | Values: 126.0 127.0 127.0 127.0 127.0 127.0 127.0 126.0 127.0 127.0 21:24:11 INFO - PROCESS | 19152 | 21:24:11 INFO - PROCESS | 19152 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 21:24:11 INFO - PROCESS | 19152 | Values: 147.0 146.0 147.0 146.0 147.0 147.0 147.0 147.0 147.0 147.0 21:24:11 INFO - PROCESS | 19152 | 21:24:11 INFO - PROCESS | 19152 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 21:24:11 INFO - PROCESS | 19152 | Values: 96.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 96.0 21:24:11 INFO - PROCESS | 19152 | 21:24:11 INFO - PROCESS | 19152 | [#8] json-parse-financial Cycles:10 Average:65.10 Median:64.50 stddev:3.57 (5.5%) stddev-sans-first:3.77 21:24:11 INFO - PROCESS | 19152 | Values: 64.0 63.0 75.0 63.0 65.0 65.0 63.0 65.0 64.0 64.0 21:24:11 INFO - PROCESS | 19152 | 21:24:11 INFO - PROCESS | 19152 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.00 stddev:2.72 (4.1%) stddev-sans-first:2.88 21:24:11 INFO - PROCESS | 19152 | Values: 67.0 67.0 67.0 66.0 75.0 66.0 66.0 67.0 67.0 66.0 21:24:11 INFO - PROCESS | 19152 | 21:24:11 INFO - PROCESS | 19152 | [#10] stanford-crypto-aes Cycles:10 Average:85.80 Median:85.00 stddev:1.81 (2.1%) stddev-sans-first:1.74 21:24:11 INFO - PROCESS | 19152 | Values: 88.0 85.0 86.0 85.0 85.0 85.0 85.0 90.0 85.0 84.0 21:24:11 INFO - PROCESS | 19152 | 21:24:11 INFO - PROCESS | 19152 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:138.50 stddev:16.61 (12.0%) stddev-sans-first:17.61 21:24:11 INFO - PROCESS | 19152 | Values: 141.0 146.0 134.0 135.0 137.0 140.0 134.0 133.0 188.0 134.0 21:24:11 INFO - PROCESS | 19152 | 21:24:11 INFO - PROCESS | 19152 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:183.70 Median:183.00 stddev:2.06 (1.1%) stddev-sans-first:1.48 21:24:11 INFO - PROCESS | 19152 | Values: 188.0 182.0 183.0 183.0 183.0 185.0 183.0 181.0 183.0 186.0 21:24:11 INFO - PROCESS | 19152 | 21:24:11 INFO - PROCESS | 19152 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:69.00 stddev:2.69 (3.9%) stddev-sans-first:2.40 21:24:11 INFO - PROCESS | 19152 | Values: 74.0 68.0 73.0 69.0 69.0 74.0 68.0 69.0 68.0 67.0 21:24:11 INFO - PROCESS | 19152 | -------- Summary: end -------- 21:24:11 INFO - PROCESS | 19152 | 21:24:12 INFO - TEST-INFO | 19152: exit 0 21:24:12 INFO - TEST-OK | kraken | took 63937ms 21:24:12 INFO - SUITE-END | took 1185s 21:24:13 INFO - Completed test suite (00:19:45) 21:24:13 INFO - javascript benchmark 21:24:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2573.420980279437, 2600.973990260097, 2616.960745588816, 2636.419987602727, 2645.7089720130784, 4615.28463088221, 4646.25659894417, 4688.976555117224, 4693.2256177730715, 4705.10602985433, 4713.905721885569, 4717.952820471794, 4739.668223224376, 4784.5693887550115, 4822.252550854614, 4263.062126332202, 4291.763952982585, 4345.348197770328, 4371.606555410012, 4460.8661740147845, 3922.627350401707, 4349.69552131351, 4360.084382279725, 4403.141387429452, 4431.6233120184825, 4393.934090988638, 4451.955480445203, 4465.196264672358, 4467.262901621229, 4472.396226509429, 4227.661787057028, 4269.252880745857, 4276.166147601219, 4312.439382880237, 4339.7830108494445, 4335.479742430928, 4351.086271882877, 4379.583939525772, 4390.846320378803, 4414.073044660625, 4701.0, 4702.952970470285, 4725.621950243973, 4755.096531659008, 4799.520047995207, 4922.507749225085, 4967.304577359173, 4967.7019378837385, 5085.389753229636, 5097.286379906816, 5045.4197767256865, 5056.115179843513, 5076.695398276078, 5108.897822043576, 5149.794008239666, 4758.455783865305, 4760.619150468024, 4762.4285085789925, 4764.6426518011285, 4808.0383923215495, 4909.361782968192, 5218.321618189611, 5228.241904923841, 5236.73816309183, 5280.841574752763, 4777.689450185727, 4836.177849765478, 4937.308776771255, 4966.205407134841, 4969.478204788517, 5072.82245121419, 5077.568406685473, 5079.31429257053, 5081.2378143278065, 5112.156494178494, 4991.401031876198, 5028.547430731252, 5036.546710796046, 5068.391792984866, 5087.847364579068, 4873.220284754422, 4926.211806111005, 4931.950680493149, 4932.062908047459, 4952.851414457572, 4324.372965919924, 4353.194658988034, 4360.41134446852, 4393.340998850134, 4404.2512772828695, 3786.734928554975, 3787.6780473660046, 3792.981035094862, 3807.8286477108595, 3826.0243637872163, 4200.5169405518145, 4234.343676730112, 4347.673924455678, 4354.9564504355185, 4380.69335146543, 4994.0, 5005.224190250517, 5026.447090820006, 5046.571041461517, 5094.923576146361, 4329.6969212154845, 4341.435613370241, 4342.34864770287, 4343.348497725303, 4377.649788016951, 4488.236999710057, 4576.6109880660515, 4578.290364993365, 4581.060882519076, 4619.792109355087, 4629.513901040342, 4705.5059218781535, 4733.384659994179, 4755.952440475551, 4771.045790841776, 5134.15286477727, 5155.896882062413, 5161.948380516147, 5163.535281824654, 5190.870228244324, 4798.352222449925, 4798.7840547174765, 4799.712017278975, 4803.639727020418, 4833.9274910875665, 4849.660523763303, 4863.562279394871, 4883.633727470383, 4905.141600219876, 5103.642745007963, 4957.801687932442, 4969.726665033458, 5005.34930459038, 5015.598752099896, 5051.747412629427, 5004.599632029502, 5037.269595908646, 5042.042012017705, 5048.0156369507595, 5076.543111120017, 4765.833195838268, 4797.136515427256, 4865.7323847188745, 5040.49595040493, 5048.470288633209, 4777.713337199779, 4847.781849816696, 4852.927206091841, 4871.415430148405, 4895.241237608177, 4773.856784296477, 4930.260460930889, 4955.35580374549, 4972.701637901738, 4983.725895075806, 4653.953460465487, 4768.928466072943, 4849.2726091086615, 4854.660173787801, 4903.8528844134735], "value": 4637.501722400255, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.37705245495584, 538.1282322637328, 542.3193891665958, 543.128279112025, 554.7669978608986, 36576.268474630524, 37457.625423745754, 37469.437958430644, 37501.437478437845, 37530.99999999996, 37567.43648845263, 38100.23799524008, 38127.23745525088, 38129.42805857914, 38170.0, 7385.0, 7463.552186868778, 7632.885506717404, 7633.618319084051, 7637.350825179867, 7397.742383794768, 9600.231981441468, 9819.754506137333, 9824.803503929917, 10154.949225253864, 9911.851322230137, 9964.352317099401, 9974.800503989916, 9980.800383992315, 9984.900150998506, 9783.559739811726, 9836.704898853046, 9842.212622990215, 9843.557039933221, 9851.556679949384, 9625.374350667184, 9686.32195746298, 9687.225021998223, 9695.90304096957, 9699.51502424883, 36571.63428365709, 36825.26349472995, 36863.81568092169, 36892.63107368919, 36901.446478302845, 2860.7997440179197, 2873.6407949006375, 3016.909492715222, 3031.5301128325145, 3251.0734440684528, 26928.192154235403, 27365.726342736714, 27541.86229068862, 27668.0, 28295.292617684518, 3354.1279267390655, 3429.4855771634207, 3433.5536380270655, 3442.1566716154452, 3443.1220038889924, 239063.80468097722, 239837.0, 239901.0, 240102.0, 240313.0, 48840.7557962215, 49162.508374916506, 49175.75412122916, 49260.26109608359, 49272.75363623159, 50435.0, 50526.0, 50554.0, 50585.74707126514, 50587.49412505901, 13655.0, 13818.447262109403, 13840.93079534596, 13849.307534623229, 13865.37605807741, 10012.299139060342, 10301.0, 10410.063094321547, 10670.199735019905, 10671.413072281099, 14359.138451692932, 14897.702045959237, 14959.177245251398, 15013.174275414738, 15223.259813233724, 5511.476409741068, 5549.972250138723, 5699.800506982236, 5737.627054241461, 5788.88422231553, 738.623302115914, 759.7910574591921, 801.6993627389729, 819.0989911097745, 924.9676261330821, 24760.752392475846, 26196.08313709011, 26698.5995210072, 26706.465870682867, 26728.465430691667, 931.3247895275871, 945.8486642137225, 951.6003278622995, 998.3610489286863, 1002.9268682509645, 12758.298293593756, 13747.862521374658, 14035.78946315806, 14039.438422462987, 14059.718805624036, 331389.0, 336365.0, 336661.0, 336946.0, 336990.0, 48657.0, 48700.26949595688, 48721.269180962314, 48725.37108974642, 48832.26751598729, 1031.3657100882904, 1077.2190162132547, 1085.2077983072559, 1129.0515966588105, 1137.4824454873012, 25620.743792561836, 27190.01819599685, 27446.588301175896, 29899.850500747358, 30452.086437406913, 45271.0, 45957.31064034109, 45988.54011459843, 46024.0, 46024.76987615041, 301131.0, 303689.0, 303813.0, 305440.0, 305460.0, 21580.46048848791, 21950.0, 22168.0, 23523.059077636703, 23926.282211533682, 35265.29469410649, 38990.610093899835, 39034.6096539031, 39600.811975640776, 39630.80184599059, 32977.67022329746, 33114.66885331116, 33147.83426082854, 33248.83375583107, 33783.83108084444, 32038.0, 32509.0, 32789.508157378135, 33375.666243337255, 33853.0, 32858.835705822275, 32895.83552082224, 32950.34099318048, 33005.0, 33482.497762533094, 27725.44549108966, 29938.25154371071, 30910.69089309168, 31224.21939451532, 31375.0, 23965.0, 24293.635595466436, 24359.75640243575, 24674.259772206864, 24747.381315467257], "value": 16946.187271760165, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.59526437493435, 360.7673050882181, 363.5020022569081, 369.9482072509851, 377.5526001688, 15199.0, 15859.286332115054, 16507.66984660306, 16531.0, 16542.338306467725, 15686.13726245056, 16572.254248558813, 16659.416920407788, 16753.748693769605, 16762.07808570528, 4831.3719216501895, 4986.800527978877, 5006.4492905780335, 5016.724080175589, 5017.473165317644, 3713.8885833424906, 3881.068543549556, 4903.730294833783, 4998.425181104165, 5530.5852061095375, 5846.181534585162, 5861.765529378819, 5866.618669786471, 5868.119782032687, 5874.588778785486, 5664.150377443396, 5738.282714660668, 5768.567357448208, 5773.797917072924, 5851.356350801409, 5067.366579177603, 5072.9746351268, 5073.137566613685, 5074.264231686422, 5075.086484432801, 19342.709859352122, 19693.21227150912, 19890.602187956305, 19900.70148947767, 20055.6991645124, 1852.3424184414473, 1910.5414700471927, 1935.554822390858, 2065.5765568058514, 2274.1699279762765, 12159.878401215963, 12716.364181790967, 12784.488620455171, 13505.86494135056, 13564.525241616595, 1710.0, 1749.7462867884085, 1781.1272476486558, 1791.6237590106093, 1796.9820301797076, 61243.38756612421, 61463.385366146664, 62842.0, 63236.0, 63978.68010659963, 9177.77055573616, 9217.76955576116, 9293.210077143518, 9443.197328227177, 9780.657676981271, 13010.089293749535, 13041.282729449782, 13048.869511304765, 13049.608511744664, 13088.214707117604, 6363.61818290904, 6435.4529864962005, 6497.902531462032, 6527.640979746065, 6553.803385898431, 5761.193432919395, 5761.8559536011935, 5793.102069179284, 5808.912866307009, 5987.43119403656, 5877.94122058774, 5999.370066142992, 6028.5478589106, 6068.575199735976, 6125.754969801158, 1542.7608720648318, 1648.777415048977, 1668.8247733987998, 1677.004364805877, 1682.0, 710.9751158709421, 784.8430313937235, 851.5699571716243, 879.7360791762445, 919.2186641354795, 16189.352425902833, 16883.0, 17371.3051477942, 17563.64872702539, 17834.19746111428, 809.9311558517475, 859.9011113721876, 869.8303830752942, 878.1481962496368, 891.6149300620814, 9577.042295770507, 9841.901580984242, 9946.0, 10032.247581431277, 10060.74848128788, 315687.0, 336053.0, 337346.0, 337441.0, 338938.0, 63027.0, 64817.67591162108, 65162.022569661494, 65631.67184164049, 66423.66788166028, 913.123401534521, 952.3048174832411, 962.0523784072683, 982.2485798364257, 988.3526290279879, 13878.722425551634, 14707.0, 14735.0, 14997.925010374878, 15493.690126197638, 34879.65120348764, 35908.64091359053, 36015.27969440649, 36795.63204367922, 37138.814305928296, 43738.34392484179, 45387.0, 45668.314975276066, 46578.53421465742, 48832.51167488279, 7626.54240745557, 7650.6174691264105, 7792.727254546064, 7874.56689882062, 7879.881801772864, 7248.782536523912, 8700.173483519056, 9628.66299679508, 11498.54005839757, 11801.881981180079, 6364.840878977878, 9782.510874456106, 9879.950600246953, 9885.802283954137, 9953.452560109263, 10104.242181836245, 10260.97390260968, 10273.332233404804, 10286.742831429274, 10471.94764026175, 10353.378797272188, 10376.584936602452, 10414.687559373231, 10513.684589462327, 11108.555657773599, 7324.304191101837, 7390.778276651709, 7465.141508726349, 7511.136219334847, 7521.849563008818, 9138.954305228432, 9692.369995950241, 10189.643362482277, 10195.184385249311, 10782.083522900328], "value": 8014.745052289925, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1321.9867801321986, 1333.9799903001453, 1387.3964825300995, 1609.6378314879162, 1640.1471234957814, 7057.082579264695, 7423.257674232581, 7423.517471364357, 7426.220246874068, 7432.256774322572, 6472.611643301405, 6716.966415167917, 7029.261927497616, 7238.059052323204, 7264.96367518163, 2143.2605751015876, 2178.9782102178933, 2191.4521369657587, 2192.243675931801, 2193.616117179495, 2123.373604786592, 2167.1223154622403, 2182.1053368119074, 2182.9563408731815, 2185.694002839604, 1813.7098064309714, 1870.6819840627127, 2065.648839697255, 2157.0, 2159.708439360682, 2111.788821117884, 2116.2698868890207, 2123.522207503315, 2129.318618042227, 2136.7756385579523, 2144.7962443567835, 2160.6975023496725, 2180.574787916357, 2180.7928246816527, 2188.9233876814396, 7295.416366690652, 7375.852482950365, 7376.409887209064, 7376.594287314196, 7394.186639469654, 4414.624756895636, 4556.567126123046, 4558.658100642465, 4559.863204103849, 4564.589186973155, 2659.255408485627, 2845.701201373867, 2849.3873817129415, 2852.1586132091084, 2869.0962346860674, 775.6121939030485, 809.3969992355733, 829.3448175940999, 879.2702057292432, 880.5509190312987, 9894.109530142321, 9931.255155863339, 9973.301868869255, 9985.301028927977, 9985.500724963722, 3928.9214215715524, 4098.918021639551, 4142.2543942090115, 4205.705600607989, 4233.04756429807, 8590.14098590136, 8600.39797214189, 8614.095519970439, 8616.956915215509, 8622.482651040958, 4499.752513611717, 4537.478190008125, 4579.06129243511, 4582.427196600425, 4585.105904348687, 3986.80065996699, 4144.91710165795, 4154.50145982484, 4160.105577300895, 4191.057012172237, 3327.351166522505, 3354.966450335465, 3389.6271410144864, 3433.3305005524185, 3444.3111377724053, 1117.452448300327, 1139.4302848575712, 1159.47244003978, 1163.627639155462, 1164.6622479481025, 564.2692712936757, 621.5462712220015, 768.9577073260913, 801.939854510914, 820.5856042698399, 4871.756412179377, 4924.901501969941, 5026.648134630614, 5102.566281866083, 5138.845834624967, 797.4338219863846, 797.5453991225062, 842.4945032980286, 874.5976850648645, 876.7983363826355, 3331.900042998714, 3381.4758712399616, 3399.286149908547, 3411.8123503207066, 3586.55168103987, 8603.698870539502, 9047.502387368626, 9068.773280667903, 9076.319276054322, 9080.545972701471, 9008.549572521348, 9029.097090290918, 9032.051634578274, 9034.096590341045, 9046.0, 6759.898601520981, 6857.691403886737, 6926.515143939876, 6994.160700715946, 7000.509964302551, 4847.297141914332, 4875.9512404875495, 4916.345173606355, 4944.307796908363, 5027.899442011212, 8146.14465481116, 8160.224778646019, 8233.917660823316, 8237.093919668952, 8242.752717418487, 7621.1616722161625, 7917.406194535318, 7930.9603451982375, 8147.470414423044, 8369.246767790928, 6298.307186209605, 6431.967840160769, 6448.838779030561, 6448.967755161382, 6455.515836312202, 6956.304369563206, 7002.334778196063, 7026.156861176692, 7026.2271150174465, 7031.472639552157, 6254.937450625435, 6303.590266632654, 6315.684215789101, 6349.238091429058, 6582.045603387578, 6068.4841788448475, 6181.660008699565, 6316.778912738032, 6375.7449702013255, 6505.739770409131, 5858.209141765978, 6131.172291740736, 6131.509479241561, 6131.509479241739, 6133.785317513865, 4289.892752681208, 4320.870373888788, 4354.9782251088545, 4379.233634114081, 4423.203823311835, 4392.626626736763, 4474.597286244254, 4493.797779099883, 4529.909401812011, 4556.134334476439], "value": 3936.0167934947017, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.4606245163867, 354.7711725936771, 357.85864583489524, 360.77631868241696, 363.75083068098354, 4848.060775689726, 4852.902941941159, 4857.392825896763, 4884.560389564938, 4908.558229759321, 4834.34736310598, 4851.0, 4865.683730557511, 4873.610111191105, 4881.5118488151165, 3637.5271214742047, 3713.3501637213517, 3774.8867533974026, 3838.445429601002, 3889.941650875225, 3887.1448281378052, 3897.532296124469, 3920.1571662092642, 3933.5476420211758, 3939.881803545884, 3804.8097595120134, 3861.4014827701753, 3870.542205699373, 3870.9225815483674, 3902.2780785554623, 3679.374506333916, 3765.7740535567955, 3773.2642134783728, 3828.770273783568, 3842.654161125512, 3439.2949445363643, 3453.5855697316483, 3474.1835668617855, 3476.4263896457055, 3492.2491664292297, 4623.942345656184, 4640.419947506562, 4640.976795116037, 4651.976740116312, 4681.74250416227, 4305.182015417061, 4394.8461803837035, 4429.512753597101, 4442.888927776799, 4445.53321901199, 4978.452370239271, 5020.3724534433195, 5025.0954828130925, 5027.974860125712, 5038.0, 3762.6425489578446, 3804.90487737806, 3812.1803812180515, 3814.1608846053823, 3818.350880350319, 5066.898662026812, 5254.448282930313, 5261.842144735664, 5285.841424757264, 5308.734563271821, 3862.3627101528496, 3872.9225415491533, 3884.5921178275876, 3886.9222615548097, 3890.455336252927, 3910.7066969976795, 3933.665638420709, 3933.7412028150716, 3943.7633741975, 3947.3289540778137, 4393.538678438718, 4406.030673251879, 4408.911821763547, 4412.977935110304, 4414.602685758297, 4945.530174633404, 5011.398632164163, 5017.0, 5032.647714659939, 5099.847004589794, 1333.9132956357805, 1340.6782372230593, 1347.723716638087, 1350.257358452847, 1364.836219653648, 950.1347708894853, 975.0, 979.7942432089341, 980.2158273381267, 990.6235630460523, 4291.50647675515, 4354.673399495051, 4424.3142312941545, 4465.129299786576, 4511.819527218874, 5187.948120518822, 5194.68831870089, 5209.4009188943, 5214.843554693365, 5224.738763061908, 4452.30989196675, 4458.598726114666, 4476.328550717419, 4478.888027799266, 4490.7754612269255, 2579.9871000644875, 2672.492226476963, 2682.771964383049, 2691.8250313729545, 2707.6750789905336, 4699.418067384341, 4709.0, 4714.222153344728, 4721.457032441244, 4758.643101767381, 5131.435542090367, 5161.922571161435, 5169.638125331191, 5177.171652535576, 5178.870528236749, 4602.0, 4868.221084626513, 4892.828750993698, 4902.656814022984, 4921.434035086011, 5210.5831533477985, 5225.843224703113, 5241.344831896013, 5250.241169208358, 5288.8413347599635, 4931.876703082308, 5151.330327057609, 5171.612129090258, 5174.602857228602, 5183.796886323373, 4884.072026314989, 4914.0, 4917.262410638433, 4921.760598927551, 4926.802927882844, 3705.462233173203, 3705.981470092632, 3728.6830619397656, 3735.5890852005714, 3748.4564738112276, 5108.233764935289, 5280.287161233338, 5281.392639846313, 5284.603654725834, 5306.602004849575, 5104.821331253388, 5124.154514505065, 5126.564242039469, 5137.561482784826, 5153.845384638467, 5104.846854594368, 5106.7701953412925, 5135.2553879687985, 5158.587313014875, 5159.561437277874, 4813.470518243061, 5056.7724452399, 5064.721440320818, 5068.518490743373, 5086.880886205177, 4924.310596516562, 4977.502249774993, 5021.246812977936, 5128.58971282304, 5141.940545375495, 4971.160670551919, 4980.975095124501, 4985.5762260208285, 5001.57486613642, 5001.7749201285305], "value": 3880.5050739900166, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [609.9237595300588, 648.1800522339239, 677.8779819632467, 706.7385067525016, 719.2914978745938, 14730.484433044845, 15305.617359566017, 15408.69182616347, 15417.922910385447, 15419.383224670999, 14213.147211167312, 14719.705605887875, 14792.482263120794, 14800.185989770558, 14809.629759256024, 604.7308947518334, 758.8861670749391, 780.8438312337527, 781.4646966827713, 782.5734974438944, 626.1046703214402, 747.872861613527, 770.214381331042, 774.2335088262607, 781.1914668318292, 814.3810703865075, 818.2022528035178, 819.1071731812324, 819.8319344534386, 819.942604017719, 635.4757325206676, 805.7179987004531, 806.7378102116835, 807.0396228488139, 807.6284908941893, 484.9490803465656, 571.7455732199173, 592.943670351316, 593.2762030323042, 596.8239369386041, 12993.285369304684, 13010.349482525837, 13024.54414095502, 13027.28349940753, 13028.478860845555, 11869.287842729464, 12076.939615301868, 12354.938225308815, 12385.07111966597, 12581.496740130475, 11345.602903898323, 11439.885601143966, 11527.13546484017, 11651.941740291244, 11658.6502404928, 3920.764754114734, 3949.3483575210057, 3977.6817854571855, 3990.7206495545324, 4004.8598299059686, 49736.76184571703, 62336.37663623351, 64570.0, 65527.0, 65549.0, 9817.361871478332, 9917.404955702681, 10122.848157277647, 10125.443100629389, 10167.898321016695, 17757.911210443865, 17828.732569011474, 17828.821711782977, 17843.0, 17847.73228401575, 6193.969030154821, 6487.448566871774, 6537.967310163419, 6744.831379215559, 6752.088468056848, 3586.677199052098, 3649.1606930405624, 3654.543182102237, 3659.798711070863, 3689.2805902849223, 2643.762061414482, 2694.3533551947785, 2705.4724328756097, 2726.3865630233436, 2745.052956729925, 477.05781082362057, 478.5406010230218, 478.96304500755474, 479.09451137350436, 489.3418352316129, 446.7386578851408, 488.22372427839906, 558.2101326622783, 559.8012705489574, 586.9148973398918, 7363.374113200438, 7945.761627151194, 7996.04047514302, 8081.555514446762, 8123.431359804875, 498.5338708307744, 535.1063723581628, 535.5661913849716, 559.5439716630933, 568.6815383385317, 3446.7070299024863, 3458.8097654629237, 3502.754807163525, 3507.7369197310304, 3676.8345424455965, 63662.36337636657, 65053.0, 66270.33729662737, 67866.0, 68009.65995169993, 46498.5350146501, 52476.0, 57774.7111264441, 58996.0, 59237.0, 52984.735076324374, 53207.73396133072, 53214.201786974, 53656.46343536593, 53904.46095538994, 6535.509836762357, 6764.0868482754195, 6769.120014398097, 6831.077804496329, 6985.685644145924, 37098.258034839695, 37372.0, 37533.249335013694, 37866.43200351942, 39251.0, 45219.0, 46464.767676161406, 48883.75558122186, 49165.508344916096, 50239.49760502348, 9002.954985225031, 9124.726258212264, 9156.313276504156, 9332.486713230837, 9413.388129771543, 9721.368111072758, 9840.803183936425, 10157.339772914736, 10442.791144176921, 10637.27743250527, 9673.903260967581, 10278.17774578017, 10471.790564188826, 10477.0, 10492.632757853438, 10005.210530233366, 10219.386836789816, 10234.283600147919, 10245.077942985166, 10470.633527826489, 9488.146066854017, 9623.182029527568, 9629.085236902483, 9744.0, 9832.164266037467, 8186.345092392475, 8399.244068033906, 8821.735347939572, 9004.189622933967, 9023.548822558978, 8211.096779354148, 8293.377996650155, 8503.277221436247, 8528.658853645784, 8597.570121493774], "value": 5992.0224900044705, "unit": "score"}], "name": "dromaeo_css", "value": 6215.397301284182, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 117.0, 116.0, 114.0, 114.0, 115.0, 114.0, 114.0, 115.0, 114.0], "value": 114.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 135.0, 123.0, 156.0, 127.0, 127.0, 132.0, 124.0, 153.0, 128.0], "value": 135.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 162.0, 161.0, 161.0, 161.0, 161.0, 162.0, 160.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 75.0, 114.0, 76.0, 78.0, 78.0, 76.0, 99.0, 75.0], "value": 82.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 90.0, 118.0, 84.0, 84.0, 85.0, 107.0, 85.0, 83.0, 118.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 127.0, 127.0, 127.0, 127.0, 127.0, 127.0, 126.0, 127.0, 127.0], "value": 126.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 63.0, 75.0, 63.0, 65.0, 65.0, 63.0, 65.0, 64.0, 64.0], "value": 65.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 75.0, 66.0, 66.0, 67.0, 67.0, 66.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 86.0, 85.0, 85.0, 85.0, 85.0, 90.0, 85.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 146.0, 134.0, 135.0, 137.0, 140.0, 134.0, 133.0, 188.0, 134.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 182.0, 183.0, 183.0, 183.0, 185.0, 183.0, 181.0, 183.0, 186.0], "value": 183.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 68.0, 73.0, 69.0, 69.0, 74.0, 68.0, 69.0, 68.0, 67.0], "value": 69.9, "unit": "score"}], "name": "kraken", "value": 1570.5, "alertThreshold": 2.0}]} 21:24:13 INFO - Return code: 0 21:24:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:24:13 INFO - # TBPL SUCCESS # 21:24:13 INFO - Running post-action listener: _resource_record_post_action 21:24:13 INFO - [mozharness: 2016-12-18 05:24:13.326031Z] Finished run-tests step (success) 21:24:13 INFO - Running post-run listener: _resource_record_post_run 21:24:13 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 0; Write bytes: 386347008; Read time: 0; Write time: 212236 21:24:13 INFO - TinderboxPrint: CPU usage
13.1% 21:24:13 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 21:24:13 INFO - TinderboxPrint: I/O write bytes / time
386,347,008 / 212,236 21:24:13 INFO - TinderboxPrint: CPU idle
8,339.1 (86.9%) 21:24:13 INFO - TinderboxPrint: CPU user
1,211.8 (12.6%) 21:24:13 INFO - TinderboxPrint: Swap in / out
0 / 0 21:24:13 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 98992128; Read time: 0; Write time: 56556 21:24:13 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 286302208; Read time: 0; Write time: 155620 21:24:13 INFO - Running post-run listener: _upload_blobber_files 21:24:13 INFO - Blob upload gear active. 21:24:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:24:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:24:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:24:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:24:14 INFO - (blobuploader) - INFO - Open directory for files ... 21:24:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:24:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:24:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:24:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:24:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:24:15 INFO - (blobuploader) - INFO - Done attempting. 21:24:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:24:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:24:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:24:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:24:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:24:18 INFO - (blobuploader) - INFO - Done attempting. 21:24:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:24:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:24:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:24:19 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:24:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:24:19 INFO - (blobuploader) - INFO - Done attempting. 21:24:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:24:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:24:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:24:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:24:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:24:20 INFO - (blobuploader) - INFO - Done attempting. 21:24:20 INFO - (blobuploader) - INFO - Iteration through files over. 21:24:20 INFO - Return code: 0 21:24:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:24:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:24:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d339d44b0f9ce736f1226d6121f878b5fab789078ac5fddc693e7a8d86e2a5320eaa4ce566e5369c2a23dc615ffde87c554fcfdd2eec5a97b9a6b09909d14fdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab4cc17677110409a8f906cce5ce89d33db5b0f08370e590702b63788b1d28619dad6676fb25211da50c427992aa681fa5dee756db8294481b9e5c6dbfd8b498", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ed41b6f013cfb9c8b31ee3fdf17ddb7afac2dd9a18f65cab3a63024602dec848109d724681520b90a5d8867364bcca2c16bd4a3e0c97c749982ce118cba73c99", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1768e67e896ca8ad2e64177339ce5c8a774d952c7c3d76afede031578e74cc10633e2bc7ac6682605cb26c02598ce3ebcf6fbb25d2043ac04540975ba3d7c2f9"} 21:24:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:24:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:24:20 INFO - Contents: 21:24:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d339d44b0f9ce736f1226d6121f878b5fab789078ac5fddc693e7a8d86e2a5320eaa4ce566e5369c2a23dc615ffde87c554fcfdd2eec5a97b9a6b09909d14fdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab4cc17677110409a8f906cce5ce89d33db5b0f08370e590702b63788b1d28619dad6676fb25211da50c427992aa681fa5dee756db8294481b9e5c6dbfd8b498", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ed41b6f013cfb9c8b31ee3fdf17ddb7afac2dd9a18f65cab3a63024602dec848109d724681520b90a5d8867364bcca2c16bd4a3e0c97c749982ce118cba73c99", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1768e67e896ca8ad2e64177339ce5c8a774d952c7c3d76afede031578e74cc10633e2bc7ac6682605cb26c02598ce3ebcf6fbb25d2043ac04540975ba3d7c2f9"} 21:24:20 INFO - Running post-run listener: copy_logs_to_upload_dir 21:24:20 INFO - Copying logs to upload dir... 21:24:20 INFO - mkdir: /builds/slave/test/build/upload/logs 21:24:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.389767 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-12-17 21:24:20.060288) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-17 21:24:20.064245) ========= 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=ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d339d44b0f9ce736f1226d6121f878b5fab789078ac5fddc693e7a8d86e2a5320eaa4ce566e5369c2a23dc615ffde87c554fcfdd2eec5a97b9a6b09909d14fdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab4cc17677110409a8f906cce5ce89d33db5b0f08370e590702b63788b1d28619dad6676fb25211da50c427992aa681fa5dee756db8294481b9e5c6dbfd8b498", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ed41b6f013cfb9c8b31ee3fdf17ddb7afac2dd9a18f65cab3a63024602dec848109d724681520b90a5d8867364bcca2c16bd4a3e0c97c749982ce118cba73c99", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1768e67e896ca8ad2e64177339ce5c8a774d952c7c3d76afede031578e74cc10633e2bc7ac6682605cb26c02598ce3ebcf6fbb25d2043ac04540975ba3d7c2f9"} build_url:https://queue.taskcluster.net/v1/task/IgiTXn4yQn6GvXkzVrguDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011259 build_url: 'https://queue.taskcluster.net/v1/task/IgiTXn4yQn6GvXkzVrguDA/artifacts/public/build/firefox-53.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d339d44b0f9ce736f1226d6121f878b5fab789078ac5fddc693e7a8d86e2a5320eaa4ce566e5369c2a23dc615ffde87c554fcfdd2eec5a97b9a6b09909d14fdb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ab4cc17677110409a8f906cce5ce89d33db5b0f08370e590702b63788b1d28619dad6676fb25211da50c427992aa681fa5dee756db8294481b9e5c6dbfd8b498", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ed41b6f013cfb9c8b31ee3fdf17ddb7afac2dd9a18f65cab3a63024602dec848109d724681520b90a5d8867364bcca2c16bd4a3e0c97c749982ce118cba73c99", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/1768e67e896ca8ad2e64177339ce5c8a774d952c7c3d76afede031578e74cc10633e2bc7ac6682605cb26c02598ce3ebcf6fbb25d2043ac04540975ba3d7c2f9"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-17 21:24:20.089862) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:24:20.090215) ========= 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=ed14279e38b05397cf4aa391000001a4-1482037367.596592-311851824 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004476 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-17 21:24:20.175958) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-17 21:24:20.176310) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-17 21:24:20.176607) ========= ========= Total master_lag: 0.17 =========