builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-005 starttime: 1491133667.72 results: success (0) revision: 896992d97d7c684b8eac6bf576e72d032f86b18b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-02 04:47:47.718457) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-02 04:47:47.718928) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-02 04:47:47.719208) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-02 04:47:47.782373) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 04:47:47.782743) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-02 04:47:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 68.5M=0s 2017-04-02 04:47:48 (68.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.322594 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 04:47:48.129979) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 04:47:48.130314) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.077161 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 04:47:48.220051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-02 04:47:48.220394) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 896992d97d7c684b8eac6bf576e72d032f86b18b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 896992d97d7c684b8eac6bf576e72d032f86b18b --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=7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-02 04:47:48,264 truncating revision to first 12 chars 2017-04-02 04:47:48,264 Setting DEBUG logging. 2017-04-02 04:47:48,264 attempt 1/10 2017-04-02 04:47:48,264 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/896992d97d7c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-02 04:47:49,014 unpacking tar archive at: mozilla-central-896992d97d7c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.171889 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-02 04:47:49.411297) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-02 04:47:49.411858) ========= script_repo_revision: 896992d97d7c684b8eac6bf576e72d032f86b18b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-02 04:47:49.412335) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-02 04:47:49.412751) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-02 04:47:49.424251) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-04-02 04:47:49.424655) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:47:49 INFO - MultiFileLogger online at 20170402 04:47:49 in /builds/slave/test 04:47:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:47:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:47:49 INFO - {'append_to_log': False, 04:47:49 INFO - 'base_work_dir': '/builds/slave/test', 04:47:49 INFO - 'blob_upload_branch': 'Firefox', 04:47:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:47:49 INFO - 'branch': 'Firefox', 04:47:49 INFO - 'buildbot_json_path': 'buildprops.json', 04:47:49 INFO - 'config_files': ('talos/linux_config.py',), 04:47:49 INFO - 'default_actions': ('clobber', 04:47:49 INFO - 'read-buildbot-config', 04:47:49 INFO - 'download-and-extract', 04:47:49 INFO - 'populate-webroot', 04:47:49 INFO - 'create-virtualenv', 04:47:49 INFO - 'install', 04:47:49 INFO - 'run-tests'), 04:47:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:47:49 INFO - 'download_minidump_stackwalk': True, 04:47:49 INFO - 'download_symbols': 'ondemand', 04:47:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:47:49 INFO - 'tooltool.py': '/tools/tooltool.py', 04:47:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:47:49 INFO - '/tools/misc-python/virtualenv.py')}, 04:47:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:47:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:47:49 INFO - 'gecko_profile': False, 04:47:49 INFO - 'gecko_profile_interval': 0, 04:47:49 INFO - 'installer_path': 'installer.exe', 04:47:49 INFO - 'log_level': 'info', 04:47:49 INFO - 'log_name': 'talos', 04:47:49 INFO - 'log_to_console': True, 04:47:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:47:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:47:49 INFO - 'opt_config_files': (), 04:47:49 INFO - 'pip_index': False, 04:47:49 INFO - 'suite': 'dromaeojs', 04:47:49 INFO - 'system_bits': '32', 04:47:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:47:49 INFO - 'title': 'talos-linux64-ix-005', 04:47:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:47:49 INFO - 'use_talos_json': True, 04:47:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:47:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:47:49 INFO - 'work_dir': 'build'} 04:47:49 INFO - [mozharness: 2017-04-02 11:47:49.686857Z] Running clobber step. 04:47:49 INFO - Running pre-action listener: _resource_record_pre_action 04:47:49 INFO - Running main action method: clobber 04:47:49 INFO - rmtree: /builds/slave/test/build 04:47:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:47:54 INFO - Running post-action listener: _resource_record_post_action 04:47:54 INFO - [mozharness: 2017-04-02 11:47:54.936926Z] Finished clobber step (success) 04:47:54 INFO - [mozharness: 2017-04-02 11:47:54.937024Z] Running read-buildbot-config step. 04:47:54 INFO - Running pre-action listener: _resource_record_pre_action 04:47:54 INFO - Running main action method: read_buildbot_config 04:47:54 INFO - Using buildbot properties: 04:47:54 INFO - { 04:47:54 INFO - "project": "", 04:47:54 INFO - "product": "firefox", 04:47:54 INFO - "who": "archaeopteryx@coole-files.de", 04:47:54 INFO - "installer_path": "public/build/target.tar.bz2", 04:47:54 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:47:54 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 04:47:54 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 04:47:54 INFO - "stage_platform": "linux64-pgo", 04:47:54 INFO - "basedir": "/builds/slave/test", 04:47:54 INFO - "buildnumber": 119, 04:47:54 INFO - "platform": "ubuntu64_hw", 04:47:54 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:47:54 INFO - "slavebuilddir": "test", 04:47:54 INFO - "taskId": "A2ni-o3ASluuI6BZI88qKQ", 04:47:54 INFO - "branch": "mozilla-central", 04:47:54 INFO - "script_repo_revision": "production", 04:47:54 INFO - "revision": "896992d97d7c684b8eac6bf576e72d032f86b18b", 04:47:54 INFO - "slavename": "talos-linux64-ix-005", 04:47:54 INFO - "repo_path": "mozilla-central" 04:47:54 INFO - } 04:47:54 INFO - Finding installer, test and symbols from parent task. 04:47:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A2ni-o3ASluuI6BZI88qKQ'}, attempt #1 04:47:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/A2ni-o3ASluuI6BZI88qKQ'}, attempt #1 04:47:55 INFO - Task dependencies: KOQdqULDTkGAcgX2SelByg 04:47:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg'}, attempt #1 04:47:56 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg/artifacts/public/build/target.tar.bz2 04:47:56 INFO - Set test_url: https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg/artifacts/public/build/test_packages.json 04:47:56 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg/artifacts/public/build/target.crashreporter-symbols.zip 04:47:56 INFO - Running post-action listener: _resource_record_post_action 04:47:56 INFO - [mozharness: 2017-04-02 11:47:56.424880Z] Finished read-buildbot-config step (success) 04:47:56 INFO - [mozharness: 2017-04-02 11:47:56.425096Z] Running download-and-extract step. 04:47:56 INFO - Running pre-action listener: _resource_record_pre_action 04:47:56 INFO - Running main action method: download_and_extract 04:47:56 INFO - mkdir: /builds/slave/test/build/tests 04:47: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')]} 04:47:56 INFO - trying https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg/artifacts/public/build/target.test_packages.json 04:47:56 INFO - Downloading https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 04:47:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 04:47:57 INFO - Downloaded 986 bytes. 04:47:57 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 04:47:57 INFO - Using the following test package requirements: 04:47:57 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 04:47:57 INFO - u'common': [u'target.common.tests.zip'], 04:47:57 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 04:47:57 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 04:47:57 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 04:47:57 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 04:47:57 INFO - u'mozbase': [u'target.common.tests.zip'], 04:47:57 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 04:47:57 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 04:47:57 INFO - u'web-platform': [u'target.common.tests.zip', 04:47:57 INFO - u'target.web-platform.tests.zip'], 04:47:57 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 04:47:57 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 04:47:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg/artifacts/public/build/target.common.tests.zip 04:47:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:47:57 INFO - Fetch https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg/artifacts/public/build/target.common.tests.zip into memory 04:47:59 INFO - Expected file size: 60358360 04:47:59 INFO - Obtained file size: 60358360 04:48:09 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 04:48:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg/artifacts/public/build/target.common.tests.zip 04:48:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg/artifacts/public/build/target.common.tests.zip'}, attempt #1 04:48:09 INFO - Fetch https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg/artifacts/public/build/target.common.tests.zip into memory 04:48:11 INFO - Expected file size: 60358360 04:48:11 INFO - Obtained file size: 60358360 04:48:22 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg/artifacts/public/build/target.talos.tests.zip 04:48:22 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg/artifacts/public/build/target.talos.tests.zip'}, attempt #1 04:48:22 INFO - Fetch https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg/artifacts/public/build/target.talos.tests.zip into memory 04:48:23 INFO - Expected file size: 14404152 04:48:23 INFO - Obtained file size: 14404152 04:48:23 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')]} 04:48:23 INFO - trying https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg/artifacts/public/build/target.tar.bz2 04:48:23 INFO - Downloading https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 04:48:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 04:48:25 INFO - Downloaded 67902700 bytes. 04:48:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg/artifacts/public/build/target.tar.bz2 04:48:25 INFO - mkdir: /builds/slave/test/properties 04:48:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:48:25 INFO - Writing to file /builds/slave/test/properties/build_url 04:48:25 INFO - Contents: 04:48:25 INFO - build_url:https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg/artifacts/public/build/target.tar.bz2 04:48:25 INFO - Running post-action listener: _resource_record_post_action 04:48:25 INFO - Running post-action listener: set_extra_try_arguments 04:48:25 INFO - [mozharness: 2017-04-02 11:48:25.294830Z] Finished download-and-extract step (success) 04:48:25 INFO - [mozharness: 2017-04-02 11:48:25.294926Z] Running populate-webroot step. 04:48:25 INFO - Running pre-action listener: _resource_record_pre_action 04:48:25 INFO - Running main action method: populate_webroot 04:48:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:48:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:48:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:48:25 INFO - '--tppagecycles', 04:48:25 INFO - '7'], 04:48:25 INFO - 'tests': ['tsvgm']}}, 04:48:25 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:48:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:48:25 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:48:25 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:48:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:48:25 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:48:25 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:48:25 INFO - 'talos_options': ['--disable-e10s'], 04:48:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:48:25 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:48:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:48:25 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:48:25 INFO - 'talos_options': ['--disable-e10s'], 04:48:25 INFO - 'tests': ['damp', 'tps']}, 04:48:25 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:48:25 INFO - 'tests': ['damp', 'tps']}, 04:48:25 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:48:25 INFO - 'tests': ['dromaeo_dom']}, 04:48:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:48:25 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:48:25 INFO - 'tests': ['basic_compositor_video']}, 04:48:25 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:48:25 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:48:25 INFO - 'tests': ['a11yr', 04:48:25 INFO - 'ts_paint', 04:48:25 INFO - 'tpaint', 04:48:25 INFO - 'sessionrestore', 04:48:25 INFO - 'sessionrestore_no_auto_restore', 04:48:25 INFO - 'tabpaint']}, 04:48:25 INFO - 'other-e10s': {'tests': ['a11yr', 04:48:25 INFO - 'ts_paint', 04:48:25 INFO - 'tpaint', 04:48:25 INFO - 'sessionrestore', 04:48:25 INFO - 'sessionrestore_no_auto_restore', 04:48:25 INFO - 'tabpaint']}, 04:48:25 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:48:25 INFO - 'ts_paint', 04:48:25 INFO - 'tpaint', 04:48:25 INFO - 'sessionrestore', 04:48:25 INFO - 'sessionrestore_no_auto_restore', 04:48:25 INFO - 'tabpaint']}, 04:48:25 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:48:25 INFO - 'ts_paint', 04:48:25 INFO - 'tpaint', 04:48:25 INFO - 'sessionrestore', 04:48:25 INFO - 'sessionrestore_no_auto_restore', 04:48:25 INFO - 'tabpaint']}, 04:48:25 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:48:25 INFO - 'tests': ['a11yr', 04:48:25 INFO - 'ts_paint', 04:48:25 INFO - 'tpaint', 04:48:25 INFO - 'sessionrestore', 04:48:25 INFO - 'sessionrestore_no_auto_restore', 04:48:25 INFO - 'tabpaint']}, 04:48:25 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:48:25 INFO - 'tests': ['a11yr', 04:48:25 INFO - 'ts_paint', 04:48:25 INFO - 'tpaint', 04:48:25 INFO - 'sessionrestore', 04:48:25 INFO - 'sessionrestore_no_auto_restore', 04:48:25 INFO - 'tabpaint']}, 04:48:25 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:48:25 INFO - 'tests': ['tsvgx', 04:48:25 INFO - 'tsvgr_opacity', 04:48:25 INFO - 'tart', 04:48:25 INFO - 'tscrollx', 04:48:25 INFO - 'cart', 04:48:25 INFO - 'tsvg_static']}, 04:48:25 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:48:25 INFO - 'tsvgr_opacity', 04:48:25 INFO - 'tart', 04:48:25 INFO - 'tscrollx', 04:48:25 INFO - 'cart', 04:48:25 INFO - 'tsvg_static']}, 04:48:25 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:48:25 INFO - 'talos_options': ['--disable-e10s'], 04:48:25 INFO - 'tests': ['tp5o']}, 04:48:25 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:48:25 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:48:25 INFO - 'talos_options': ['--disable-e10s', 04:48:25 INFO - '--xperf_path', 04:48:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:48:25 INFO - 'tests': ['tp5n']}, 04:48:25 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:48:25 INFO - 'talos_options': ['--xperf_path', 04:48:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:48:25 INFO - 'tests': ['tp5n']}}, 04:48:25 INFO - 'talos.zip': {'path': '', 04:48:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:48:25 INFO - Running post-action listener: _resource_record_post_action 04:48:25 INFO - [mozharness: 2017-04-02 11:48:25.308000Z] Finished populate-webroot step (success) 04:48:25 INFO - [mozharness: 2017-04-02 11:48:25.308090Z] Running create-virtualenv step. 04:48:25 INFO - Running pre-action listener: _resource_record_pre_action 04:48:25 INFO - Running main action method: create_virtualenv 04:48:25 INFO - Creating virtualenv /builds/slave/test/build/venv 04:48:25 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 04:48:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:48:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:48:25 INFO - Using real prefix '/usr' 04:48:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:48:26 INFO - Installing distribute.............................................................................................................................................................................................done. 04:48:27 INFO - Installing pip.................done. 04:48:27 INFO - Return code: 0 04:48:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:48:28 INFO - Reading from file tmpfile_stdout 04:48:28 INFO - Output received: 04:48:28 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) 04:48:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:48:28 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')]} 04:48:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:28 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')]} 04:48:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:28 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 0x1f6d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208400>, '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 0x22093b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2209840>, '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': '7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761', '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 04:48:28 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 04:48:28 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 04:48:28 INFO - Using env: {'DISPLAY': ':0', 04:48:28 INFO - 'HOME': '/home/cltbld', 04:48:28 INFO - 'LANG': 'en_US.UTF-8', 04:48:28 INFO - 'LANGUAGE': 'en_US:en', 04:48:28 INFO - 'LOGNAME': 'cltbld', 04:48:28 INFO - 'MAIL': '/var/mail/cltbld', 04:48:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:28 INFO - 'MOZ_NO_REMOTE': '1', 04:48:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:28 INFO - 'NO_EM_RESTART': '1', 04:48:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:28 INFO - 'PWD': '/builds/slave/test', 04:48:28 INFO - 'SHELL': '/bin/bash', 04:48:28 INFO - 'SHLVL': '1', 04:48:28 INFO - 'TERM': 'linux', 04:48:28 INFO - 'TMOUT': '86400', 04:48:28 INFO - 'USER': 'cltbld', 04:48:28 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761', 04:48:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:28 INFO - '_': '/tools/buildbot/bin/python'} 04:48:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:28 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 04:48:28 INFO - Cleaning up... 04:48:28 INFO - Return code: 0 04:48:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:48:28 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')]} 04:48:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:28 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')]} 04:48:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:28 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 0x1f6d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208400>, '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 0x22093b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2209840>, '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': '7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761', '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 04:48:28 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 04:48:28 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 04:48:28 INFO - Using env: {'DISPLAY': ':0', 04:48:28 INFO - 'HOME': '/home/cltbld', 04:48:28 INFO - 'LANG': 'en_US.UTF-8', 04:48:28 INFO - 'LANGUAGE': 'en_US:en', 04:48:28 INFO - 'LOGNAME': 'cltbld', 04:48:28 INFO - 'MAIL': '/var/mail/cltbld', 04:48:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:28 INFO - 'MOZ_NO_REMOTE': '1', 04:48:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:28 INFO - 'NO_EM_RESTART': '1', 04:48:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:28 INFO - 'PWD': '/builds/slave/test', 04:48:28 INFO - 'SHELL': '/bin/bash', 04:48:28 INFO - 'SHLVL': '1', 04:48:28 INFO - 'TERM': 'linux', 04:48:28 INFO - 'TMOUT': '86400', 04:48:28 INFO - 'USER': 'cltbld', 04:48:28 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761', 04:48:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:28 INFO - '_': '/tools/buildbot/bin/python'} 04:48:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:28 INFO - Downloading/unpacking psutil>=3.1.1 04:48:28 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 04:48:28 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 04:48:28 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 04:48:28 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 04:48:28 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 04:48:28 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 04:48:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:48:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:48:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:48:30 INFO - Installing collected packages: psutil 04:48:30 INFO - Running setup.py install for psutil 04:48:30 INFO - building 'psutil._psutil_linux' extension 04:48:30 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 04:48:31 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 04:48:32 INFO - building 'psutil._psutil_posix' extension 04:48:32 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 04:48:32 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 04:48:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:48:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:48:32 INFO - Successfully installed psutil 04:48:32 INFO - Cleaning up... 04:48:32 INFO - Return code: 0 04:48:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:48:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:32 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 0x1f6d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208400>, '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 0x22093b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2209840>, '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': '7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761', '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 04:48:32 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 04:48:32 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 04:48:32 INFO - Using env: {'DISPLAY': ':0', 04:48:32 INFO - 'HOME': '/home/cltbld', 04:48:32 INFO - 'LANG': 'en_US.UTF-8', 04:48:32 INFO - 'LANGUAGE': 'en_US:en', 04:48:32 INFO - 'LOGNAME': 'cltbld', 04:48:32 INFO - 'MAIL': '/var/mail/cltbld', 04:48:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:32 INFO - 'MOZ_NO_REMOTE': '1', 04:48:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:32 INFO - 'NO_EM_RESTART': '1', 04:48:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:32 INFO - 'PWD': '/builds/slave/test', 04:48:32 INFO - 'SHELL': '/bin/bash', 04:48:32 INFO - 'SHLVL': '1', 04:48:32 INFO - 'TERM': 'linux', 04:48:32 INFO - 'TMOUT': '86400', 04:48:32 INFO - 'USER': 'cltbld', 04:48:32 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761', 04:48:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:32 INFO - '_': '/tools/buildbot/bin/python'} 04:48:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:48:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:48:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:48:34 INFO - Installing collected packages: mozsystemmonitor 04:48:34 INFO - Running setup.py install for mozsystemmonitor 04:48:34 INFO - Successfully installed mozsystemmonitor 04:48:34 INFO - Cleaning up... 04:48:34 INFO - Return code: 0 04:48:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:34 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 0x1f6d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208400>, '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 0x22093b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2209840>, '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': '7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761', '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 04:48:34 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 04:48:34 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 04:48:34 INFO - Using env: {'DISPLAY': ':0', 04:48:34 INFO - 'HOME': '/home/cltbld', 04:48:34 INFO - 'LANG': 'en_US.UTF-8', 04:48:34 INFO - 'LANGUAGE': 'en_US:en', 04:48:34 INFO - 'LOGNAME': 'cltbld', 04:48:34 INFO - 'MAIL': '/var/mail/cltbld', 04:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:34 INFO - 'MOZ_NO_REMOTE': '1', 04:48:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:34 INFO - 'NO_EM_RESTART': '1', 04:48:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:34 INFO - 'PWD': '/builds/slave/test', 04:48:34 INFO - 'SHELL': '/bin/bash', 04:48:34 INFO - 'SHLVL': '1', 04:48:34 INFO - 'TERM': 'linux', 04:48:34 INFO - 'TMOUT': '86400', 04:48:34 INFO - 'USER': 'cltbld', 04:48:34 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761', 04:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:34 INFO - '_': '/tools/buildbot/bin/python'} 04:48:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:34 INFO - Downloading/unpacking jsonschema==2.5.1 04:48:34 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 04:48:34 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 04:48:34 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 04:48:34 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 04:48:34 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 04:48:34 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 04:48:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:48:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:48:37 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 04:48:37 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 04:48:37 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 04:48:37 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 04:48:37 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 04:48:37 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 04:48:37 INFO - Downloading functools32-3.2.3-2.tar.gz 04:48:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:48:37 INFO - warning: no files found matching '*.txt' 04:48:37 INFO - no previously-included directories found matching 'build' 04:48:37 INFO - no previously-included directories found matching 'dist' 04:48:37 INFO - no previously-included directories found matching '.git*' 04:48:37 INFO - Installing collected packages: jsonschema, functools32 04:48:37 INFO - Running setup.py install for functools32 04:48:37 INFO - warning: no files found matching '*.txt' 04:48:37 INFO - no previously-included directories found matching 'build' 04:48:37 INFO - no previously-included directories found matching 'dist' 04:48:37 INFO - no previously-included directories found matching '.git*' 04:48:37 INFO - Successfully installed jsonschema functools32 04:48:37 INFO - Cleaning up... 04:48:37 INFO - Return code: 0 04:48:37 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:48:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:37 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 0x1f6d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208400>, '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 0x22093b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2209840>, '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': '7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761', '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 04:48:37 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 04:48:37 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 04:48:37 INFO - Using env: {'DISPLAY': ':0', 04:48:37 INFO - 'HOME': '/home/cltbld', 04:48:37 INFO - 'LANG': 'en_US.UTF-8', 04:48:37 INFO - 'LANGUAGE': 'en_US:en', 04:48:37 INFO - 'LOGNAME': 'cltbld', 04:48:37 INFO - 'MAIL': '/var/mail/cltbld', 04:48:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:37 INFO - 'MOZ_NO_REMOTE': '1', 04:48:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:37 INFO - 'NO_EM_RESTART': '1', 04:48:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:37 INFO - 'PWD': '/builds/slave/test', 04:48:37 INFO - 'SHELL': '/bin/bash', 04:48:37 INFO - 'SHLVL': '1', 04:48:37 INFO - 'TERM': 'linux', 04:48:37 INFO - 'TMOUT': '86400', 04:48:37 INFO - 'USER': 'cltbld', 04:48:37 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761', 04:48:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:37 INFO - '_': '/tools/buildbot/bin/python'} 04:48:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:37 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:48:37 INFO - Cleaning up... 04:48:37 INFO - Return code: 0 04:48:37 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:48:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:48:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:37 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 0x1f6d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208400>, '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 0x22093b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2209840>, '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': '7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761', '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 04:48:37 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 04:48:37 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 04:48:37 INFO - Using env: {'DISPLAY': ':0', 04:48:37 INFO - 'HOME': '/home/cltbld', 04:48:37 INFO - 'LANG': 'en_US.UTF-8', 04:48:37 INFO - 'LANGUAGE': 'en_US:en', 04:48:37 INFO - 'LOGNAME': 'cltbld', 04:48:37 INFO - 'MAIL': '/var/mail/cltbld', 04:48:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:37 INFO - 'MOZ_NO_REMOTE': '1', 04:48:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:37 INFO - 'NO_EM_RESTART': '1', 04:48:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:37 INFO - 'PWD': '/builds/slave/test', 04:48:37 INFO - 'SHELL': '/bin/bash', 04:48:37 INFO - 'SHLVL': '1', 04:48:37 INFO - 'TERM': 'linux', 04:48:37 INFO - 'TMOUT': '86400', 04:48:37 INFO - 'USER': 'cltbld', 04:48:37 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761', 04:48:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:37 INFO - '_': '/tools/buildbot/bin/python'} 04:48:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:37 INFO - Downloading/unpacking blobuploader==1.2.4 04:48:37 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 04:48:37 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 04:48:37 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 04:48:37 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 04:48:37 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 04:48:37 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 04:48:39 INFO - Downloading blobuploader-1.2.4.tar.gz 04:48:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:48:40 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:48:40 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 04:48:40 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 04:48:40 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 04:48:40 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 04:48:40 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 04:48:40 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 04:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:48:40 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:48:40 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 04:48:40 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 04:48:40 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 04:48:40 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 04:48:40 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 04:48:40 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 04:48:40 INFO - Downloading docopt-0.6.1.tar.gz 04:48:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:48:40 INFO - Installing collected packages: blobuploader, requests, docopt 04:48:40 INFO - Running setup.py install for blobuploader 04:48:40 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:48:40 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:48:40 INFO - Running setup.py install for requests 04:48:41 INFO - Running setup.py install for docopt 04:48:41 INFO - Successfully installed blobuploader requests docopt 04:48:41 INFO - Cleaning up... 04:48:41 INFO - Return code: 0 04:48:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:41 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 0x1f6d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208400>, '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 0x22093b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2209840>, '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': '7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761', '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 04:48:41 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 04:48:41 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 04:48:41 INFO - Using env: {'DISPLAY': ':0', 04:48:41 INFO - 'HOME': '/home/cltbld', 04:48:41 INFO - 'LANG': 'en_US.UTF-8', 04:48:41 INFO - 'LANGUAGE': 'en_US:en', 04:48:41 INFO - 'LOGNAME': 'cltbld', 04:48:41 INFO - 'MAIL': '/var/mail/cltbld', 04:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:41 INFO - 'MOZ_NO_REMOTE': '1', 04:48:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:41 INFO - 'NO_EM_RESTART': '1', 04:48:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:41 INFO - 'PWD': '/builds/slave/test', 04:48:41 INFO - 'SHELL': '/bin/bash', 04:48:41 INFO - 'SHLVL': '1', 04:48:41 INFO - 'TERM': 'linux', 04:48:41 INFO - 'TMOUT': '86400', 04:48:41 INFO - 'USER': 'cltbld', 04:48:41 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761', 04:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:41 INFO - '_': '/tools/buildbot/bin/python'} 04:48:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:48:41 INFO - Running setup.py (path:/tmp/pip-6to5B9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:48:41 INFO - Running setup.py (path:/tmp/pip-3MYno8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:48:41 INFO - Running setup.py (path:/tmp/pip-B5YCSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:48:41 INFO - Running setup.py (path:/tmp/pip-3g7N3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:48:41 INFO - Running setup.py (path:/tmp/pip-OpS2GH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:48:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:48:41 INFO - Running setup.py (path:/tmp/pip-B_5CTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:48:42 INFO - Running setup.py (path:/tmp/pip-fXP3Ee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:48:42 INFO - Running setup.py (path:/tmp/pip-7B5Re9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:48:42 INFO - Running setup.py (path:/tmp/pip-SdMhex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:48:42 INFO - Running setup.py (path:/tmp/pip-Psna0H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:48:42 INFO - Running setup.py (path:/tmp/pip-jvD32r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:48:42 INFO - Running setup.py (path:/tmp/pip-b906kI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:48:42 INFO - Running setup.py (path:/tmp/pip-Yq3Xz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:48:42 INFO - Running setup.py (path:/tmp/pip-lvIDEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:48:42 INFO - Running setup.py (path:/tmp/pip-FvIoMG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:48:42 INFO - Running setup.py (path:/tmp/pip-yQ0gjj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:48:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:48:42 INFO - Running setup.py (path:/tmp/pip-ELXRsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:48:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:48:42 INFO - Running setup.py install for manifestparser 04:48:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:48:42 INFO - Running setup.py install for mozcrash 04:48:43 INFO - Running setup.py install for mozdebug 04:48:43 INFO - Running setup.py install for mozdevice 04:48:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:48:43 INFO - Running setup.py install for mozfile 04:48:43 INFO - Running setup.py install for mozhttpd 04:48:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:48:43 INFO - Running setup.py install for mozinfo 04:48:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:48:43 INFO - Running setup.py install for mozInstall 04:48:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:48:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:48:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:48:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:48:43 INFO - Running setup.py install for mozleak 04:48:43 INFO - Running setup.py install for mozlog 04:48:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:48:43 INFO - Running setup.py install for moznetwork 04:48:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:48:43 INFO - Running setup.py install for mozprocess 04:48:44 INFO - Running setup.py install for mozprofile 04:48:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:48:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:48:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:48:44 INFO - Running setup.py install for mozrunner 04:48:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:48:44 INFO - Running setup.py install for mozscreenshot 04:48:44 INFO - Running setup.py install for moztest 04:48:44 INFO - Running setup.py install for mozversion 04:48:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:48:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:48:44 INFO - Cleaning up... 04:48:44 INFO - Return code: 0 04:48:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:48: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')]} 04:48:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48: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')]} 04:48:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:44 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 0x1f6d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208400>, '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 0x22093b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2209840>, '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': '7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761', '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 04:48:44 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 04:48:44 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 04:48:44 INFO - Using env: {'DISPLAY': ':0', 04:48:44 INFO - 'HOME': '/home/cltbld', 04:48:44 INFO - 'LANG': 'en_US.UTF-8', 04:48:44 INFO - 'LANGUAGE': 'en_US:en', 04:48:44 INFO - 'LOGNAME': 'cltbld', 04:48:44 INFO - 'MAIL': '/var/mail/cltbld', 04:48:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:44 INFO - 'MOZ_NO_REMOTE': '1', 04:48:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:44 INFO - 'NO_EM_RESTART': '1', 04:48:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:44 INFO - 'PWD': '/builds/slave/test', 04:48:44 INFO - 'SHELL': '/bin/bash', 04:48:44 INFO - 'SHLVL': '1', 04:48:44 INFO - 'TERM': 'linux', 04:48:44 INFO - 'TMOUT': '86400', 04:48:44 INFO - 'USER': 'cltbld', 04:48:44 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761', 04:48:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:44 INFO - '_': '/tools/buildbot/bin/python'} 04:48:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:48:44 INFO - Running setup.py (path:/tmp/pip-tpWfso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:48:44 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)) 04:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:48:44 INFO - Running setup.py (path:/tmp/pip-z_1lJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:48:44 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)) 04:48:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:48:44 INFO - Running setup.py (path:/tmp/pip-W7ENAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:48:45 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)) 04:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:48:45 INFO - Running setup.py (path:/tmp/pip-ONBxwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:48:45 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)) 04:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:48:45 INFO - Running setup.py (path:/tmp/pip-x7ahje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:48:45 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)) 04:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:48:45 INFO - Running setup.py (path:/tmp/pip-18Tfzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:48:45 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)) 04:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:48:45 INFO - Running setup.py (path:/tmp/pip-6jk6ON-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:48:45 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)) 04:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:48:45 INFO - Running setup.py (path:/tmp/pip-REq_Pl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:48:45 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)) 04:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:48:45 INFO - Running setup.py (path:/tmp/pip-BctqaY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:48:45 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)) 04:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:48:45 INFO - Running setup.py (path:/tmp/pip-AQ5pbn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:48:45 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)) 04:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:48:45 INFO - Running setup.py (path:/tmp/pip-Dnbp3k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:48:45 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)) 04:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:48:45 INFO - Running setup.py (path:/tmp/pip-nUIe5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 04:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:48:45 INFO - Running setup.py (path:/tmp/pip-PwdvVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:48:45 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)) 04:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:48:45 INFO - Running setup.py (path:/tmp/pip-cw_Kyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:48:45 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)) 04:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:48:45 INFO - Running setup.py (path:/tmp/pip-hUb4L2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:48:45 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)) 04:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:48:45 INFO - Running setup.py (path:/tmp/pip-cLLZzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:48:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:48:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:48:46 INFO - Running setup.py (path:/tmp/pip-JIINIZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:48:46 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)) 04:48:46 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)) 04:48:46 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)) 04:48:46 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)) 04:48:46 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)) 04:48:46 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)) 04:48:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:48:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:48:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:48:48 INFO - Downloading blessings-1.6.tar.gz 04:48:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:48:48 INFO - Installing collected packages: blessings 04:48:48 INFO - Running setup.py install for blessings 04:48:48 INFO - Successfully installed blessings 04:48:48 INFO - Cleaning up... 04:48:48 INFO - Return code: 0 04:48:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:48:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:48:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:48:48 INFO - Reading from file tmpfile_stdout 04:48:48 INFO - Current package versions: 04:48:48 INFO - argparse == 1.2.1 04:48:48 INFO - blessings == 1.6 04:48:48 INFO - blobuploader == 1.2.4 04:48:48 INFO - docopt == 0.6.1 04:48:48 INFO - functools32 == 3.2.3-2 04:48:48 INFO - jsonschema == 2.5.1 04:48:48 INFO - manifestparser == 1.1 04:48:48 INFO - mozInstall == 1.12 04:48:48 INFO - mozcrash == 1.0 04:48:48 INFO - mozdebug == 0.1 04:48:48 INFO - mozdevice == 0.49 04:48:48 INFO - mozfile == 1.2 04:48:48 INFO - mozhttpd == 0.7 04:48:48 INFO - mozinfo == 0.9 04:48:48 INFO - mozleak == 0.1 04:48:48 INFO - mozlog == 3.4 04:48:48 INFO - moznetwork == 0.27 04:48:48 INFO - mozprocess == 0.25 04:48:48 INFO - mozprofile == 0.28 04:48:48 INFO - mozrunner == 6.13 04:48:48 INFO - mozscreenshot == 0.1 04:48:48 INFO - mozsystemmonitor == 0.3 04:48:48 INFO - moztest == 0.8 04:48:48 INFO - mozversion == 1.4 04:48:48 INFO - psutil == 3.1.1 04:48:48 INFO - requests == 1.2.3 04:48:48 INFO - wsgiref == 0.1.2 04:48:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:48:48 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')]} 04:48:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:48 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')]} 04:48:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:48 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 0x1f6d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208400>, '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 0x22093b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2209840>, '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': '7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761', '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 04:48:48 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 04:48:48 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 04:48:48 INFO - Using env: {'DISPLAY': ':0', 04:48:48 INFO - 'HOME': '/home/cltbld', 04:48:48 INFO - 'LANG': 'en_US.UTF-8', 04:48:48 INFO - 'LANGUAGE': 'en_US:en', 04:48:48 INFO - 'LOGNAME': 'cltbld', 04:48:48 INFO - 'MAIL': '/var/mail/cltbld', 04:48:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:48 INFO - 'MOZ_NO_REMOTE': '1', 04:48:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:48 INFO - 'NO_EM_RESTART': '1', 04:48:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:48 INFO - 'PWD': '/builds/slave/test', 04:48:48 INFO - 'SHELL': '/bin/bash', 04:48:48 INFO - 'SHLVL': '1', 04:48:48 INFO - 'TERM': 'linux', 04:48:48 INFO - 'TMOUT': '86400', 04:48:48 INFO - 'USER': 'cltbld', 04:48:48 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761', 04:48:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:48 INFO - '_': '/tools/buildbot/bin/python'} 04:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:49 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)) 04:48:49 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)) 04:48:49 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)) 04:48:49 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)) 04:48:49 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)) 04:48:49 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)) 04:48:49 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)) 04:48:49 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)) 04:48:49 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)) 04:48:49 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)) 04:48:49 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)) 04:48:49 INFO - Cleaning up... 04:48:49 INFO - Return code: 0 04:48:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:48:49 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')]} 04:48:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:48:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:49 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')]} 04:48:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:48:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:48:49 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 0x1f6d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1faaa80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x220b310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2208400>, '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 0x22093b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2209840>, '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': '7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761', '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 04:48:49 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 04:48:49 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 04:48:49 INFO - Using env: {'DISPLAY': ':0', 04:48:49 INFO - 'HOME': '/home/cltbld', 04:48:49 INFO - 'LANG': 'en_US.UTF-8', 04:48:49 INFO - 'LANGUAGE': 'en_US:en', 04:48:49 INFO - 'LOGNAME': 'cltbld', 04:48:49 INFO - 'MAIL': '/var/mail/cltbld', 04:48:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:48:49 INFO - 'MOZ_NO_REMOTE': '1', 04:48:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:48:49 INFO - 'NO_EM_RESTART': '1', 04:48:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:48:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:48:49 INFO - 'PWD': '/builds/slave/test', 04:48:49 INFO - 'SHELL': '/bin/bash', 04:48:49 INFO - 'SHLVL': '1', 04:48:49 INFO - 'TERM': 'linux', 04:48:49 INFO - 'TMOUT': '86400', 04:48:49 INFO - 'USER': 'cltbld', 04:48:49 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761', 04:48:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:48:49 INFO - '_': '/tools/buildbot/bin/python'} 04:48:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:48:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:48:49 INFO - Cleaning up... 04:48:49 INFO - Return code: 0 04:48:49 INFO - Running post-action listener: _resource_record_post_action 04:48:49 INFO - Running post-action listener: _start_resource_monitoring 04:48:49 INFO - Starting resource monitoring. 04:48:49 INFO - [mozharness: 2017-04-02 11:48:49.782946Z] Finished create-virtualenv step (success) 04:48:49 INFO - [mozharness: 2017-04-02 11:48:49.783978Z] Running install step. 04:48:49 INFO - Running pre-action listener: _resource_record_pre_action 04:48:49 INFO - Running main action method: install 04:48:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:48:49 INFO - Reading from file tmpfile_stdout 04:48:49 INFO - Detecting whether we're running mozinstall >=1.0... 04:48:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:48:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:48:50 INFO - Reading from file tmpfile_stdout 04:48:50 INFO - Output received: 04:48:50 INFO - Usage: mozinstall [options] installer 04:48:50 INFO - Options: 04:48:50 INFO - -h, --help show this help message and exit 04:48:50 INFO - -d DEST, --destination=DEST 04:48:50 INFO - Directory to install application into. [default: 04:48:50 INFO - "/builds/slave/test"] 04:48:50 INFO - --app=APP Application being installed. [default: firefox] 04:48:50 INFO - mkdir: /builds/slave/test/build/application 04:48:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:48:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 04:49:06 INFO - Reading from file tmpfile_stdout 04:49:06 INFO - Output received: 04:49:06 INFO - /builds/slave/test/build/application/firefox/firefox 04:49:06 INFO - Running post-action listener: _resource_record_post_action 04:49:06 INFO - [mozharness: 2017-04-02 11:49:06.979608Z] Finished install step (success) 04:49:06 INFO - [mozharness: 2017-04-02 11:49:06.979842Z] Running run-tests step. 04:49:06 INFO - Running pre-action listener: _resource_record_pre_action 04:49:06 INFO - Running main action method: run_tests 04:49:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:49:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:49:06 INFO - Python 2.7.3 04:49:06 INFO - Return code: 0 04:49:06 INFO - grabbing minidump binary from tooltool 04:49: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')]} 04:49:06 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 0x2208400>, '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 0x22093b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2209840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:49:06 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 04:49:06 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 04:49:06 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 04:49:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:49:07 INFO - Return code: 0 04:49:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:49:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:49:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:49:07 INFO - ENV: RUST_BACKTRACE is now 1 04:49:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:49:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:49:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 04:49:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-005 --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 04:49:07 INFO - Using env: {'DISPLAY': ':0', 04:49:07 INFO - 'HOME': '/home/cltbld', 04:49:07 INFO - 'LANG': 'en_US.UTF-8', 04:49:07 INFO - 'LANGUAGE': 'en_US:en', 04:49:07 INFO - 'LOGNAME': 'cltbld', 04:49:07 INFO - 'MAIL': '/var/mail/cltbld', 04:49:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:49:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:07 INFO - 'MOZ_NO_REMOTE': '1', 04:49:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:49:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:49:07 INFO - 'NO_EM_RESTART': '1', 04:49:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:07 INFO - 'PWD': '/builds/slave/test', 04:49:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:49:07 INFO - 'RUST_BACKTRACE': '1', 04:49:07 INFO - 'SHELL': '/bin/bash', 04:49:07 INFO - 'SHLVL': '1', 04:49:07 INFO - 'TERM': 'linux', 04:49:07 INFO - 'TMOUT': '86400', 04:49:07 INFO - 'USER': 'cltbld', 04:49:07 INFO - 'XDG_SESSION_COOKIE': '7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761', 04:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:07 INFO - '_': '/tools/buildbot/bin/python'} 04:49:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-005', '--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 04:49:07 INFO - mozversion application_buildid: 20170402105315 04:49:07 INFO - mozversion application_changeset: 896992d97d7c684b8eac6bf576e72d032f86b18b 04:49:07 INFO - mozversion application_display_name: Nightly 04:49:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:49:07 INFO - mozversion application_name: Firefox 04:49:07 INFO - mozversion application_remotingname: firefox 04:49:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:49:07 INFO - mozversion application_vendor: Mozilla 04:49:07 INFO - mozversion application_version: 55.0a1 04:49:07 INFO - mozversion platform_buildid: 20170402105315 04:49:07 INFO - mozversion platform_changeset: 896992d97d7c684b8eac6bf576e72d032f86b18b 04:49:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:49:07 INFO - mozversion platform_version: 55.0a1 04:49:07 INFO - using testdate: 1491133747 04:49:07 INFO - actual date: 1491133747 04:49:07 INFO - starting webserver on 'localhost:33746' 04:49:07 INFO - SUITE-START | Running 2 tests 04:49:07 INFO - TEST-START | dromaeo_css 04:49:07 INFO - operating with platform_type : linux_ 04:49:07 INFO - Initialising browser for dromaeo_css test... 04:49:07 INFO - TEST-INFO | started process 3426 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUGBC7L/profile http://localhost:33746/getInfo.html) 04:49:13 INFO - PID 3426 | __metrics Screen width/height:1600/1200 04:49:13 INFO - PID 3426 | colorDepth:24 04:49:13 INFO - PID 3426 | Browser inner width/height: 1024/697 04:49:13 INFO - PID 3426 | __metrics 04:49:14 INFO - PID 3426 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:49:14 INFO - PID 3426 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:49:15 INFO - TEST-INFO | 3426: exit 0 04:49:15 INFO - Browser initialized. 04:49:15 INFO - Running cycle 1/1 for dromaeo_css test... 04:49:15 INFO - TEST-INFO | started process 3519 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUGBC7L/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:49:27 INFO - PID 3519 | RSS: Main: 143888384 04:49:27 INFO - PID 3519 | 04:52:31 INFO - PID 3519 | Cycle 1(1): loaded http://localhost:33746/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33746/tests/dromaeo/cssquery-ext.html) 04:52:32 INFO - PID 3519 | RSS: Main: 264085504 04:52:32 INFO - PID 3519 | 04:54:17 INFO - PID 3519 | ************************* 04:54:17 INFO - PID 3519 | A coding exception was thrown and uncaught in a Task. 04:54:17 INFO - PID 3519 | 04:54:17 ERROR - PID 3519 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:54:17 INFO - PID 3519 | Full stack: 04:54:17 INFO - PID 3519 | ************************* 04:54:17 INFO - PID 3519 | ************************* 04:54:17 INFO - PID 3519 | A coding exception was thrown and uncaught in a Task. 04:54:17 INFO - PID 3519 | 04:54:17 ERROR - PID 3519 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:54:17 INFO - PID 3519 | Full stack: 04:54:17 INFO - PID 3519 | ************************* 04:54:17 INFO - PID 3519 | ************************* 04:54:17 INFO - PID 3519 | A coding exception was thrown and uncaught in a Task. 04:54:17 INFO - PID 3519 | 04:54:17 ERROR - PID 3519 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:54:17 INFO - PID 3519 | Full stack: 04:54:17 INFO - PID 3519 | ************************* 04:54:17 INFO - PID 3519 | ************************* 04:54:17 INFO - PID 3519 | A coding exception was thrown and uncaught in a Task. 04:54:17 INFO - PID 3519 | 04:54:17 ERROR - PID 3519 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:54:17 INFO - PID 3519 | Full stack: 04:54:17 INFO - PID 3519 | ************************* 04:55:35 INFO - PID 3519 | Cycle 1(1): loaded http://localhost:33746/tests/dromaeo/cssquery-ext.html (next: http://localhost:33746/tests/dromaeo/cssquery-jquery.html) 04:55:35 INFO - PID 3519 | RSS: Main: 230834176 04:55:35 INFO - PID 3519 | 04:58:37 INFO - PID 3519 | Cycle 1(1): loaded http://localhost:33746/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33746/tests/dromaeo/cssquery-mootools.html) 04:58:38 INFO - PID 3519 | RSS: Main: 177659904 04:58:38 INFO - PID 3519 | 05:01:40 INFO - PID 3519 | Cycle 1(1): loaded http://localhost:33746/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33746/tests/dromaeo/cssquery-prototype.html) 05:01:40 INFO - PID 3519 | RSS: Main: 179146752 05:01:40 INFO - PID 3519 | 05:04:43 INFO - PID 3519 | Cycle 1(1): loaded http://localhost:33746/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33746/tests/dromaeo/cssquery-yui.html) 05:04:44 INFO - PID 3519 | RSS: Main: 185896960 05:04:44 INFO - PID 3519 | 05:07:46 INFO - PID 3519 | Cycle 1(1): loaded http://localhost:33746/tests/dromaeo/cssquery-yui.html (next: http://localhost:33746/tests/dromaeo/cssquery-dojo.html) 05:07:46 INFO - PID 3519 | RSS: Main: 275034112 05:07:46 INFO - PID 3519 | 05:07:46 INFO - PID 3519 | __start_tp_report 05:07:46 INFO - PID 3519 | _x_x_mozilla_page_load 05:07:46 INFO - PID 3519 | _x_x_mozilla_page_load_details 05:07:46 INFO - PID 3519 | |i|pagename|runs| 05:07:46 INFO - PID 3519 | |0;dojo.html;3364.2262279675674;3389.220479289762;3402.8979130626076;3420.025292791555;3437.0548099272696;5754;5805.187273781674;5960.046392577188;5984.700764961751;5993.700314984249;5772.740226689799;5818.8254352369495;5822;5825.970870145643;5838.124281357798;5233.03188910051;5268.236105764662;5314.76083576238;5327.547158491533;5344.22508736233;5356.38401583819;5385.057614917393;5392.460753924615;5396.811111611094;5398.16328469086;5246.108161612516;5262.131748261551;5440.945590544104;5447.373552041527;5457.727113644302;5077.289179514871;5299.5760339172775;5333.253344531769;5380.811671591476;5394.271773310592;5098.59211263098;5113.872153196163;5156.020356132361;5162.6128040397125;5170.1986192140275;5791.102379131242;5881.6471011739;5949.9107513387335;5960.225170727777;5998.1602575639445;6436.485081193493;6474.384933431316;6477.514186435989;6478.967605161991;6480.351964803529;6514.511411644098;6524.282328943812;6529.706163222666;6536.248331441898;6540.411362977355;5786.971065144648;5799.130130480462;6028.97507423739;6030.155778191057;6033.517318614544;6344.365563443619;6543;6552.737890484327;6607.141071660653;6629.734810607618;6304.779332723333;6310.747570097236;6312.147860038928;6317.905231421532;6327.96836015817;6133.938660613426;6151.507879369639;6161.537884658668;6428.485721142298;6450.097221319722;6318.210223722035;6412.4549413299455;6421.935780642134;6424.518161137933;6431.646259455775;6452.548321617442;6452.741890324428;6457.677116144174;6458.095866578683;6460.25707043696;4697.600703940203;4891.828785992473;4892.877678058077;4896.730679812573;4943.406791185081;4172.4993000840095;4270.0605866709275;4330.28550289205;4335;4340.370646256275;6042.395760423922;6075.088736689532;6101.816945491642;6103.023516237381;6105.725242364104;6494.1232933553365;6504.056911747864;6510.739570417225;6511;6511.609303441809;5792.189093526909;5898.8820223595285;5899.321578018583;5901.380355062656;5994.400559944058;5314.813981510629;5339.225812257201;5339.225812257201;5339.385970613352;5340.19897015443;6432.163818703539;6454.548181627241;6576.638284894281;6644.60132392058;6669;6464.612123272619;6488;6532.183477065367;6533.803985880431;6536.3136870629805;6690.096836927147;6707.832304192434;6709;6731.158605174353;6732.461403087839;6073.149759033827;6099.128199784669;6233.314335423191;6397.200349956255;6404.903926441014;6406.23125224976;6426.871462570816;6440.098386225838;6440.645764482999;6448.2262128543;6332.271788744353;6335.683215839097;6335.904961425675;6338.461230795434;6339.90490142639;6025.0661147522205;6325.304216536086;6326.810195694136;6331.90502142459;6337;6195.1636529068;6269.937300626935;6270.372962703693;6274.058891166362;6276;6343.365663433619;6350.142730731477;6362.586431881913;6364.268109167505;6367.586106903036;5800.970995144998;5979;6165.136880836776;6168.444839964245;6177.6911154441195 05:07:46 INFO - PID 3519 | |1;ext.html;754.9924500754994;805.4885147931063;829.7178959153888;1130.3048625095564;1146.6273461125136;31802.36395272096;32259.51610725835;32449.188770280754;32485.67514324856;32503.187420314443;38896.41655375172;39156.412653810214;39442.211155776866;39647;39772.40341394874;8249.79375515611;8399.160083991583;8412.242898139166;8413.873791893096;8414.621342039592;6130.1111338855835;6307.526935479835;8106.837863242761;8247.298979586712;8391.286740627054;8244.793880152984;8425.157484251587;8436.072032076467;8439.915600843975;8442.366822488308;8451.74644760655;8519.616617252177;8525.062243153248;8530.146985301482;8536.402451828406;6086.817395478142;6252.437280644764;7827.099883513355;7910;7924.286814186693;38614.80692596519;38910.61089389098;38919.8054009731;38926.61073389258;38960.41559376611;2954.3057381515328;2962.614860068177;2967.9554806677916;2978.776591755627;2987.671356150822;28589.142325730263;28651.283717907012;28822.279443013882;28877.27806804847;28986.42027159445;3632.4732913727626;3655.9268814623824;3668.3763760160837;3682.6317368263226;3737.3085979093953;219689.90155049282;220810;221635;221926;222838;48728.75635621799;48765.512344876806;48847.313397763464;48922.51077489251;48943.755281224076;50469;50713.74643126761;50719.746401268494;50758;50774.74612626913;14005.439782408794;14247.358868850926;14276.928615356857;14276.928615357065;14278.928605357114;11202.327860328407;11205.103591712643;11242.100631949588;11249.156313276537;11254.49354779037;12108.183772434206;12324.50701971911;13569.660758480919;13611.727765444635;14295;5205.323307969939;5271.446498117719;5307.814226502054;5349.679019258857;5356.1697936819855;1039.2880876599402;1059.692689120162;1069.3102948598112;1074.5433190893839;1103.3765922253901;25234.116805911704;25347.873260633947;25466.745332546438;25557.3610659735;25785.226443206735;1124.960626378073;1144.6165534545853;1154.2093665838927;1158.2297771981707;1172.3259126002413;13310.933445332712;13335.866641333656;13370.46518139283;13516.797248041286;13569.321533923265;304483;304902;305026;305223;305960;51226.23160652593;51263;51395;51437.74281128645;51527.484725153015;1434.3545404567985;1462.1884853905972;1468.7649976003788;1469.9853001470062;1504.653929596199;24046.27861164168;29092.709072909;29415;30785.230369240948;30887.382252355277;49488.50511494839;49596.50403495919;49802.50197497979;49814;49856.501434985184;263637;264201;265031;266002;266220;32588.83705581457;32966;32985;33060.66939330576;33157.33685326328;41158.794206028775;41179;41212.793936030124;41297.79351103225;41313.79343103265;30493.54259686151;30639.846800765852;30872.53691194589;31149.532757008208;31821.681783181873;31255.374892502477;31367.686323136477;31693.683063169072;31734.68265317317;32475.863344782818;35858.8207058963;36289.27421451609;36407.81796091109;37027.444588330654;37387.81306093561;30245.848770756005;30634.540481893237;30906.53640195444;31572.36855262928;33463.66536334605;26548.82297951881;26675.333116671463;26816.463670726866;26887;27168.049118280764 05:07:46 INFO - PID 3519 | |2;jquery.html;388.2003073668242;418.7934759383682;426.6330955378375;441.67095513842185;443.25311849533557;17924.731129033058;21142.57714845704;22230.777692223073;22303.44241393964;22420.439489012784;21043.789562104375;21999.12003519857;22029.66955495669;22204.55590888181;22540.21109261176;5191.325127733389;5529.723513824313;6035.215421995145;6162.969185154068;6195.28754193269;6054.757809687607;6083.452489275965;6083.48290395317;6087.995480745672;6088.726007329681;5945.078512830518;6035.5473339499495;6044.667543285118;6085.847853803668;6088.878222435548;5934.406559344075;6093.542984276175;6094.6343219406535;6125.601835880676;6140.201773769404;5478.808241711561;5532.30846144232;5536.197251398565;5536.75084621193;5537.224788529609;25876;25925.870370648216;26002.349941251432;26445.867770661214;26540.469190616273;1979.1388071676943;1982.7422435083347;1983.8412926965952;2000.3498862869626;2088.7389076365453;15460.845391546052;16264.837351626451;16411.17944102802;16596.668066638722;16889.91555042229;2102.3062389411457;2147.516808718026;2148.4951036506563;2153.3001774423374;2156.4608847788054;112867.43566282198;113859.21322981697;113991.99999999917;114283;114485.4275728616;11205.870884531912;11741.823872641917;12099.213551119148;12138.696532586579;12316.261024338568;17112.401065962633;17353.3058677654;17408;17448.214830332665;17546.947183168795;8436.282915952213;8471.279941205066;8686.218240358272;8802.735917922473;8846.823063538694;7945.364370850318;8020.8369786380645;8031.156728543536;8207.753767386988;8238.8352232955;7762.301392874669;7807.813812132612;7822.491538050009;7980.760577182694;8067.757967260992;2116.8200702940117;2183.945401364947;2200.6368949123216;2220.3006053093222;2272.5454909018263;1004.372267332917;1009.9040591143829;1026.9948650256702;1030.3302853145515;1033.1992705653179;20576.69134962947;20830.895845520674;20977.685334719685;21090.47273818136;21162.682559761615;1020.454057079459;1055.6094245129352;1057.318029870729;1066.2429674930886;1085.7882712870914;10063.345882517613;11149.386783726974;11168.832467512993;11261.099112071015;11275.267107637977;634611;640194;646082;662739;679284;105995;111165.44417278023;111978.44010780058;117495.43829829917;118087;1206.7538321914024;1212.4059210986552;1267.5310135250202;1270.0411189551828;1272;19889.701654475484;20312.695309570663;20945.89527052355;21051.8947405262;21087.15651373928;49507.25739113844;50621.746891265306;51028.74485627548;51308.48691513037;51413.485865142364;64977.35022649713;66331;66370.66814665895;68360.6581967087;70615.64692176506;9345.48599827016;9351.111644393772;9558.713238602853;9575.664851730156;9617.951910240405;15488.148151851756;15864.762028569812;15979.28352180109;16087.678246434773;16102.516924492284;13180.604581862559;13310;13362.665933351744;13511.729765404834;13556.457741690616;12443.191192572454;12615;12764.361781911053;12966.80549791735;13077.607671769862;12544.686382840502;13727;13892.72214555683;13932.721345573234;14483.927580362451;9381.484018379055;9456.763580910532;9613.951930240304;9659.32384733062;10151.289409741246;13135.671608209872;13262.336883155996;13430.261335626634;13598.320083995563;13765.040516289046 05:07:46 INFO - PID 3519 | |3;mootools.html;1300.6033159886233;1341.6981179234674;1361.63916562111;1371.5748118083402;1383.757842377584;10313.432761198132;10751.193660475466;10753.30103543269;10759.78480430392;10761.62334318299;10440.895591044087;10661.093807026393;10965.61620343288;10980.670579882597;10983.890161098387;2329.9417514562147;2369.9881500592473;2371.6679664846934;2372.7508611595795;2373.750756170603;1981.3659628918751;2264.513129677119;2366.183666635017;2373.3473294843884;2375.2517956843626;2037.6841589553642;2281.292799232235;2340.8244381671443;2353.1999120299097;2361.2207971369407;2272.874991875446;2301.7007788987407;2338.2634470141934;2339.853471798823;2343.4961483281177;2317.073170731721;2326.3718795925006;2327.697399338092;2327.883605819702;2327.953440931172;11131;11198.720031999184;11217.551297948072;11231.550737970472;11237.494312755945;5950.672713000783;6010.3689112643415;6117.113018612276;6144.477719393813;6144.846378840565;3589.6051434342203;3647.361711700442;3819.5416550013897;3840.577536470986;3880.825362858678;1312.4815697799315;1377.6280404290785;1408.4647833823185;1414.5190635184088;1441.0561082490985;15689.764653530206;15735.76396354067;15790.368385264575;15909.681806363924;15922.044677319282;4943.134951383494;5226.738663066832;5279.9208011879855;5295.894082118336;5358.303420555303;12459.19015264023;12478.251304921734;12487.375631218403;12495.687607809878;12496.87503124957;6153.138560601519;6165.260168779775;6173.228346456693;6177.4749146323065;6181.381861813873;5378.97310513445;5648.181013752983;5693.971530142406;5703.7148142592705;5712.457316554921;3803.448499967489;3969.9753125905995;4018.9799051005143;4033.1933613276874;4043.7775922324554;1054.8048611006989;1164.231607139284;1185.887340702632;1186.887245711656;1197.2577002258656;730.8063363208754;815.6207363575847;844.7803571071443;845.9957700211583;852.4544291653347;6781.694823732944;7173.92826071743;7240.2035776064595;7241.818954526179;7247.347738703542;960.558143254111;964.7298756348234;967.6419724701906;981.2983716642492;990.4750482244422;4235.435075632757;4438.822447102079;4467.15124126415;4470.687051906335;4632.745199014086;14258.42966281337;14333.78499322511;14409.414964353913;14875.47935822241;14886;14372.137671739729;14383.78424323636;14395.640108997359;14465.13209207451;14475.638109047148;9863;10053.69838904834;10068.34555753859;10077.193824494023;10079.647212347532;6417.679116044273;6440.742370305135;6452.580582262138;6488;6541.836454088686;12253.264804111783;12297.200681955645;12327.321997290235;12373.195742276723;12385.690357741129;12345.074119440898;12413.503459861504;12521.624351269476;12563.057770667054;12706.428210730355;9158.542072896194;9431.434113953184;9442.10300021497;9451.574679139592;9469.905300946903;10149.695509134737;10201.183905287411;10228.897711022795;10388.32475889095;10421.635242766466;8604.698835540727;8752.081031491602;8839.116088391109;8951.283897288331;9061.275097992013;8279.468298364822;8364.3726720495;8398.328133749408;8418.074011858569;8427.115152909102;7772.961135194288;7810.88283675734;7853.646585903533;7858.489198202098;7892.171322011336;5627.127795191752;5728.169415434655;5798;5910;5943.732532036155;5924.229850119457;5955.196048533393;5961.940380596138;6003.129546215861;6182.907256391248 05:07:46 INFO - PID 3519 | |4;prototype.html;409.89547665345333;410.21034508570995;411.5719651562375;411.77764007435985;425.3810705423607;6024.548158888079;6036.9776124998125;6039.674725230785;6042.395760423956;6046.758129674808;5770.884582308362;5890.410958904107;5932.169496270515;5948;5956.821295361146;4621;4641.280601506755;4648.093621743761;4649.51180126087;4672.509386514401;4502.144592527426;4619.475573060899;4627.074585082997;4629.629629629639;4667;4573.039661671053;4576.057857513893;4611.100835337111;4612.308153776927;4634.21218392874;4594.74728889911;4596.494385617596;4599.9080018399445;4613.907721845578;4623.2371658676275;4156.334986402191;4184.581541845791;4190.706650534464;4198.706090573661;4198.958010419888;5572.275604171472;5741.483266506035;5786.537077033827;5794.710264486759;5805.390434004411;5294.258803767476;5314.229436731691;5319.148936170194;5324.600654950856;5334.546563542103;5979.790707325266;6191.81424557264;6276.87446251077;6286.49708023357;6290.811275661737;4449.887528117971;4450;4452.287633978548;4453.977730111329;4457.598816106533;6234.937650623481;6414.390632889868;6537.836554086139;6617.205935287748;6619.371159739817;4475.328700694857;4501.347304640874;4535.274356103074;4537.75042372666;4541.3869127668;4621.168189725881;4626.21354369758;4627.514111018362;4638.257878739386;4638.466576343696;5014.924776128361;5052.863105801165;5271;5320.893582128336;5325.547328477045;6173.506119510518;6272.466840318532;6285.528585356116;6316.873662526816;6330.39861213184;1574.6457047164527;1579.778830963666;1590.5784966983758;1602.6233835048754;1603.2224371179968;1049.3651340938623;1072.8551645527755;1073.7637719701654;1082.8105081610686;1096.819024860905;6065.269859036661;6065.636061836216;6070.180525629072;6070.969645151834;6080.027195648675;6244;6492.967535162388;6532.346765323429;6534.313897040837;6559.048428207326;6057.909131363033;6080.361562036011;6085.604435711664;6087.269527656709;6095.878082438327;3415.692587667072;3423.9315213695586;3426.194844211608;3441.6577534761464;3446.4313388291152;6566.835829104215;6609.933900661028;6663.333666633298;6694.430973367221;6698.296678848748;6587.571807832475;6598;6610;6620.768273110418;6631.171103612049;6467.126937863328;6569.37590928861;6583.868322633425;6624.238212605515;6724.4284235840505;6390.936090639034;6417.625478572958;6420.839479013062;6475.287718351072;6496;6216.689165541795;6342.79486897488;6396.776112836028;6427.228732551936;6434.742610295723;6361.554691171574;6510.902336464862;6535.771248006297;6688.3646053624825;6717.630530320879;4828.720389096822;4890.951090489049;4903.387076615423;4936.086823937583;4941.481144479778;6348.42864142211;6456.806295811133;6518;6519.608823470607;6532;6314.684265786784;6315.273743519554;6321.399467050623;6326.335734747785;6366.172397588469;6320.431161195331;6321.52588555851;6330.525210609315;6350.333215012357;6360.8868448020485;6095.908561371672;6279.874402511833;6303.306636269915;6315.652639104709;6323.272823625342;6348.174737284124;6349.238091429058;6353.936460635519;6358.491320694426;6387.393197646216;5982.4316689914385;6126.724297406717;6175.382461753788;6181;6205.625034350682 05:07:46 INFO - PID 3519 | |5;yui.html;735.588070680419;737.1007371007375;743.1194035068444;755.1504557372955;757.8635845547802;15954.361825526965;16833.15834208288;16836.83163168368;16843.74734378985;16845.32618695251;15521.844781552181;15536.689266214697;15633.687326253468;15683.764743528856;15720.292586833591;862.2756884217272;888.5379602606673;889.4796544021755;891.0065277215922;898.1198425542972;955.7419496735877;957.3203025851653;960.0687333286701;960.7550074730934;961.423146112334;1006.0945149365556;1008.334499230508;1012.9341592796445;1013.1287093099928;1013.3160116921085;995.7062666513395;996.6810620601374;997.9700608981669;998.4009594243469;998.670438755209;730.8246020954986;734.0237484146127;735.2647352647352;735.4851603877307;736.2600586410676;14639.19484428356;14939.551813445614;14958.252087395587;15010.24948752558;15070.321835517429;12734.363281835871;13001.739965200737;13480.191188528719;13491.123077000062;13513.662158446019;11460.484278207417;11488.712782180428;11542.538298468051;11680.707982300426;11784.882151178464;3007.6541197762317;3017.0948715385516;3039.012320995685;3082.676318986519;3085.41377138343;83459.5827020861;84313.15686843176;84775.57612211962;85119.57440212822;85211.57394213052;9352.859707104399;9389.953050234704;9462.858057129148;9470.100340467645;9600.471974041355;18589.349372772158;18616.720749188775;18752.437426877215;18763.34328298503;19033.333833316043;7949.960250198712;7998.5600791957;8005.559694216758;8119.675212991532;8279.58602069894;4200.7675821163575;4252.978735106367;4337.240982828055;4344.9565504344555;4372.344148377769;4130.359794231899;4131.091159944807;4201.34879093741;4204.579542045833;4205.2640787862;727.0185249912681;732.6739600877559;746.2723844251811;754.1327473405628;760.7869796457001;601.8766152938724;614.1800696070795;628.7296462521068;633.5944995203074;646.7025168422484;10560;10817.188710846718;11011.28426652265;11114.444277786079;11202.887971120184;627.6108812536256;642.6658137768334;652.8563715982476;653.9673016349163;654.9115869357671;4636.884077898079;4814.325994360793;4833.758312084382;4863.489333619989;4866.562009419169;75079;77087;77549.61225193951;78709.60645196852;79977.20022799697;64961.67519162469;66809;67346.66326668335;67427.3257267421;68316;57837.71081144567;58580;59132.704336478906;59502.70248648729;60630.696846516366;10964.451777410937;11372.829407559058;11476.770464590494;11519;11615.245009074382;31574;32868.83565582157;32928.83535582307;32965.34069318648;33001.339973200884;39396;39953.60046399499;40021;40275.3958690614;40741;13059.412326445143;13214;13247.536336228572;13382.13016153947;13542.390592423562;14510.637234069232;14562.92718536443;14607.19660418687;14663.706725865637;14764.852351476347;14670.193139377438;14792.852071479147;14844.109353438827;14853.108813471226;14968.101913885203;14202.715945681235;14313.427462901784;14606.196659183846;15204.239788010334;15229;14490.782638260645;14726.779098313747;14787.482438115045;15397.307121179798;15415.226725311712;10120.949395252977;10458.99733158424;10867.891321087005;10929.890701092887;11039.668809935714;9698;10123;10129.797404051731;10131.696049118538;10155.492225388849 05:07:46 INFO - PID 3519 | __end_tp_report 05:07:46 INFO - PID 3519 | __start_cc_report 05:07:46 INFO - PID 3519 | _x_x_mozilla_cycle_collect,1236 05:07:46 INFO - PID 3519 | __end_cc_report 05:07:46 INFO - PID 3519 | __startTimestamp1491134866641__endTimestamp 05:07:46 INFO - PID 3519 | 05:07:46 INFO - PID 3519 | ------- Summary: start ------- 05:07:46 INFO - PID 3519 | Number of tests: 6 05:07:46 INFO - PID 3519 | 05:07:46 INFO - PID 3519 | [#0] dojo.html Cycles:165 Average:5913.45 Median:6161.54 stddev:723.98 (11.8%) stddev-sans-first:698.04 05:07:46 INFO - PID 3519 | Values: 3364.2 3389.2 3402.9 3420.0 3437.1 5754.0 5805.2 5960.0 5984.7 5993.7 5772.7 5818.8 5822.0 5826.0 5838.1 5233.0 5268.2 5314.8 5327.5 5344.2 5356.4 5385.1 5392.5 5396.8 5398.2 5246.1 5262.1 5440.9 5447.4 5457.7 5077.3 5299.6 5333.3 5380.8 5394.3 5098.6 5113.9 5156.0 5162.6 5170.2 5791.1 5881.6 5949.9 5960.2 5998.2 6436.5 6474.4 6477.5 6479.0 6480.4 6514.5 6524.3 6529.7 6536.2 6540.4 5787.0 5799.1 6029.0 6030.2 6033.5 6344.4 6543.0 6552.7 6607.1 6629.7 6304.8 6310.7 6312.1 6317.9 6328.0 6133.9 6151.5 6161.5 6428.5 6450.1 6318.2 6412.5 6421.9 6424.5 6431.6 6452.5 6452.7 6457.7 6458.1 6460.3 4697.6 4891.8 4892.9 4896.7 4943.4 4172.5 4270.1 4330.3 4335.0 4340.4 6042.4 6075.1 6101.8 6103.0 6105.7 6494.1 6504.1 6510.7 6511.0 6511.6 5792.2 5898.9 5899.3 5901.4 5994.4 5314.8 5339.2 5339.2 5339.4 5340.2 6432.2 6454.5 6576.6 6644.6 6669.0 6464.6 6488.0 6532.2 6533.8 6536.3 6690.1 6707.8 6709.0 6731.2 6732.5 6073.1 6099.1 6233.3 6397.2 6404.9 6406.2 6426.9 6440.1 6440.6 6448.2 6332.3 6335.7 6335.9 6338.5 6339.9 6025.1 6325.3 6326.8 6331.9 6337.0 6195.2 6269.9 6270.4 6274.1 6276.0 6343.4 6350.1 6362.6 6364.3 6367.6 5801.0 5979.0 6165.1 6168.4 6177.7 05:07:46 INFO - PID 3519 | 05:07:46 INFO - PID 3519 | [#1] ext.html Cycles:180 Average:42388.56 Median:32040.60 stddev:69515.88 (217.0%) stddev-sans-first:69640.61 05:07:46 INFO - PID 3519 | Values: 755.0 805.5 829.7 1130.3 1146.6 31802.4 32259.5 32449.2 32485.7 32503.2 38896.4 39156.4 39442.2 39647.0 39772.4 8249.8 8399.2 8412.2 8413.9 8414.6 6130.1 6307.5 8106.8 8247.3 8391.3 8244.8 8425.2 8436.1 8439.9 8442.4 8451.7 8519.6 8525.1 8530.1 8536.4 6086.8 6252.4 7827.1 7910.0 7924.3 38614.8 38910.6 38919.8 38926.6 38960.4 2954.3 2962.6 2968.0 2978.8 2987.7 28589.1 28651.3 28822.3 28877.3 28986.4 3632.5 3655.9 3668.4 3682.6 3737.3 219689.9 220810.0 221635.0 221926.0 222838.0 48728.8 48765.5 48847.3 48922.5 48943.8 50469.0 50713.7 50719.7 50758.0 50774.7 14005.4 14247.4 14276.9 14276.9 14278.9 11202.3 11205.1 11242.1 11249.2 11254.5 12108.2 12324.5 13569.7 13611.7 14295.0 5205.3 5271.4 5307.8 5349.7 5356.2 1039.3 1059.7 1069.3 1074.5 1103.4 25234.1 25347.9 25466.7 25557.4 25785.2 1125.0 1144.6 1154.2 1158.2 1172.3 13310.9 13335.9 13370.5 13516.8 13569.3 304483.0 304902.0 305026.0 305223.0 305960.0 51226.2 51263.0 51395.0 51437.7 51527.5 1434.4 1462.2 1468.8 1470.0 1504.7 24046.3 29092.7 29415.0 30785.2 30887.4 49488.5 49596.5 49802.5 49814.0 49856.5 263637.0 264201.0 265031.0 266002.0 266220.0 32588.8 32966.0 32985.0 33060.7 33157.3 41158.8 41179.0 41212.8 41297.8 41313.8 30493.5 30639.8 30872.5 31149.5 31821.7 31255.4 31367.7 31693.7 31734.7 32475.9 35858.8 36289.3 36407.8 37027.4 37387.8 30245.8 30634.5 30906.5 31572.4 33463.7 26548.8 26675.3 26816.5 26887.0 27168.0 05:07:46 INFO - PID 3519 | 05:07:46 INFO - PID 3519 | [#2] jquery.html Cycles:180 Average:36601.35 Median:11655.10 stddev:107748.18 (924.5%) stddev-sans-first:108016.13 05:07:46 INFO - PID 3519 | Values: 388.2 418.8 426.6 441.7 443.3 17924.7 21142.6 22230.8 22303.4 22420.4 21043.8 21999.1 22029.7 22204.6 22540.2 5191.3 5529.7 6035.2 6163.0 6195.3 6054.8 6083.5 6083.5 6088.0 6088.7 5945.1 6035.5 6044.7 6085.8 6088.9 5934.4 6093.5 6094.6 6125.6 6140.2 5478.8 5532.3 5536.2 5536.8 5537.2 25876.0 25925.9 26002.3 26445.9 26540.5 1979.1 1982.7 1983.8 2000.3 2088.7 15460.8 16264.8 16411.2 16596.7 16889.9 2102.3 2147.5 2148.5 2153.3 2156.5 112867.4 113859.2 113992.0 114283.0 114485.4 11205.9 11741.8 12099.2 12138.7 12316.3 17112.4 17353.3 17408.0 17448.2 17546.9 8436.3 8471.3 8686.2 8802.7 8846.8 7945.4 8020.8 8031.2 8207.8 8238.8 7762.3 7807.8 7822.5 7980.8 8067.8 2116.8 2183.9 2200.6 2220.3 2272.5 1004.4 1009.9 1027.0 1030.3 1033.2 20576.7 20830.9 20977.7 21090.5 21162.7 1020.5 1055.6 1057.3 1066.2 1085.8 10063.3 11149.4 11168.8 11261.1 11275.3 634611.0 640194.0 646082.0 662739.0 679284.0 105995.0 111165.4 111978.4 117495.4 118087.0 1206.8 1212.4 1267.5 1270.0 1272.0 19889.7 20312.7 20945.9 21051.9 21087.2 49507.3 50621.7 51028.7 51308.5 51413.5 64977.4 66331.0 66370.7 68360.7 70615.6 9345.5 9351.1 9558.7 9575.7 9618.0 15488.1 15864.8 15979.3 16087.7 16102.5 13180.6 13310.0 13362.7 13511.7 13556.5 12443.2 12615.0 12764.4 12966.8 13077.6 12544.7 13727.0 13892.7 13932.7 14483.9 9381.5 9456.8 9614.0 9659.3 10151.3 13135.7 13262.3 13430.3 13598.3 13765.0 05:07:46 INFO - PID 3519 | 05:07:46 INFO - PID 3519 | [#3] mootools.html Cycles:180 Average:6873.94 Median:2373.05 stddev:4336.00 (182.7%) stddev-sans-first:4327.94 05:07:46 INFO - PID 3519 | Values: 1300.6 1341.7 1361.6 1371.6 1383.8 10313.4 10751.2 10753.3 10759.8 10761.6 10440.9 10661.1 10965.6 10980.7 10983.9 2329.9 2370.0 2371.7 2372.8 2373.8 1981.4 2264.5 2366.2 2373.3 2375.3 2037.7 2281.3 2340.8 2353.2 2361.2 2272.9 2301.7 2338.3 2339.9 2343.5 2317.1 2326.4 2327.7 2327.9 2328.0 11131.0 11198.7 11217.6 11231.6 11237.5 5950.7 6010.4 6117.1 6144.5 6144.8 3589.6 3647.4 3819.5 3840.6 3880.8 1312.5 1377.6 1408.5 1414.5 1441.1 15689.8 15735.8 15790.4 15909.7 15922.0 4943.1 5226.7 5279.9 5295.9 5358.3 12459.2 12478.3 12487.4 12495.7 12496.9 6153.1 6165.3 6173.2 6177.5 6181.4 5379.0 5648.2 5694.0 5703.7 5712.5 3803.4 3970.0 4019.0 4033.2 4043.8 1054.8 1164.2 1185.9 1186.9 1197.3 730.8 815.6 844.8 846.0 852.5 6781.7 7173.9 7240.2 7241.8 7247.3 960.6 964.7 967.6 981.3 990.5 4235.4 4438.8 4467.2 4470.7 4632.7 14258.4 14333.8 14409.4 14875.5 14886.0 14372.1 14383.8 14395.6 14465.1 14475.6 9863.0 10053.7 10068.3 10077.2 10079.6 6417.7 6440.7 6452.6 6488.0 6541.8 12253.3 12297.2 12327.3 12373.2 12385.7 12345.1 12413.5 12521.6 12563.1 12706.4 9158.5 9431.4 9442.1 9451.6 9469.9 10149.7 10201.2 10228.9 10388.3 10421.6 8604.7 8752.1 8839.1 8951.3 9061.3 8279.5 8364.4 8398.3 8418.1 8427.1 7773.0 7810.9 7853.6 7858.5 7892.2 5627.1 5728.2 5798.0 5910.0 5943.7 5924.2 5955.2 5961.9 6003.1 6182.9 05:07:46 INFO - PID 3519 | 05:07:46 INFO - PID 3519 | [#4] prototype.html Cycles:180 Average:5293.23 Median:6044.58 stddev:1554.67 (25.7%) stddev-sans-first:1515.21 05:07:46 INFO - PID 3519 | Values: 409.9 410.2 411.6 411.8 425.4 6024.5 6037.0 6039.7 6042.4 6046.8 5770.9 5890.4 5932.2 5948.0 5956.8 4621.0 4641.3 4648.1 4649.5 4672.5 4502.1 4619.5 4627.1 4629.6 4667.0 4573.0 4576.1 4611.1 4612.3 4634.2 4594.7 4596.5 4599.9 4613.9 4623.2 4156.3 4184.6 4190.7 4198.7 4199.0 5572.3 5741.5 5786.5 5794.7 5805.4 5294.3 5314.2 5319.1 5324.6 5334.5 5979.8 6191.8 6276.9 6286.5 6290.8 4449.9 4450.0 4452.3 4454.0 4457.6 6234.9 6414.4 6537.8 6617.2 6619.4 4475.3 4501.3 4535.3 4537.8 4541.4 4621.2 4626.2 4627.5 4638.3 4638.5 5014.9 5052.9 5271.0 5320.9 5325.5 6173.5 6272.5 6285.5 6316.9 6330.4 1574.6 1579.8 1590.6 1602.6 1603.2 1049.4 1072.9 1073.8 1082.8 1096.8 6065.3 6065.6 6070.2 6071.0 6080.0 6244.0 6493.0 6532.3 6534.3 6559.0 6057.9 6080.4 6085.6 6087.3 6095.9 3415.7 3423.9 3426.2 3441.7 3446.4 6566.8 6609.9 6663.3 6694.4 6698.3 6587.6 6598.0 6610.0 6620.8 6631.2 6467.1 6569.4 6583.9 6624.2 6724.4 6390.9 6417.6 6420.8 6475.3 6496.0 6216.7 6342.8 6396.8 6427.2 6434.7 6361.6 6510.9 6535.8 6688.4 6717.6 4828.7 4891.0 4903.4 4936.1 4941.5 6348.4 6456.8 6518.0 6519.6 6532.0 6314.7 6315.3 6321.4 6326.3 6366.2 6320.4 6321.5 6330.5 6350.3 6360.9 6095.9 6279.9 6303.3 6315.7 6323.3 6348.2 6349.2 6353.9 6358.5 6387.4 5982.4 6126.7 6175.4 6181.0 6205.6 05:07:46 INFO - PID 3519 | 05:07:46 INFO - PID 3519 | [#5] yui.html Cycles:180 Average:16904.89 Median:39987.30 stddev:21605.68 (54.0%) stddev-sans-first:21632.17 05:07:46 INFO - PID 3519 | Values: 735.6 737.1 743.1 755.2 757.9 15954.4 16833.2 16836.8 16843.7 16845.3 15521.8 15536.7 15633.7 15683.8 15720.3 862.3 888.5 889.5 891.0 898.1 955.7 957.3 960.1 960.8 961.4 1006.1 1008.3 1012.9 1013.1 1013.3 995.7 996.7 998.0 998.4 998.7 730.8 734.0 735.3 735.5 736.3 14639.2 14939.6 14958.3 15010.2 15070.3 12734.4 13001.7 13480.2 13491.1 13513.7 11460.5 11488.7 11542.5 11680.7 11784.9 3007.7 3017.1 3039.0 3082.7 3085.4 83459.6 84313.2 84775.6 85119.6 85211.6 9352.9 9390.0 9462.9 9470.1 9600.5 18589.3 18616.7 18752.4 18763.3 19033.3 7950.0 7998.6 8005.6 8119.7 8279.6 4200.8 4253.0 4337.2 4345.0 4372.3 4130.4 4131.1 4201.3 4204.6 4205.3 727.0 732.7 746.3 754.1 760.8 601.9 614.2 628.7 633.6 646.7 10560.0 10817.2 11011.3 11114.4 11202.9 627.6 642.7 652.9 654.0 654.9 4636.9 4814.3 4833.8 4863.5 4866.6 75079.0 77087.0 77549.6 78709.6 79977.2 64961.7 66809.0 67346.7 67427.3 68316.0 57837.7 58580.0 59132.7 59502.7 60630.7 10964.5 11372.8 11476.8 11519.0 11615.2 31574.0 32868.8 32928.8 32965.3 33001.3 39396.0 39953.6 40021.0 40275.4 40741.0 13059.4 13214.0 13247.5 13382.1 13542.4 14510.6 14562.9 14607.2 14663.7 14764.9 14670.2 14792.9 14844.1 14853.1 14968.1 14202.7 14313.4 14606.2 15204.2 15229.0 14490.8 14726.8 14787.5 15397.3 15415.2 10120.9 10459.0 10867.9 10929.9 11039.7 9698.0 10123.0 10129.8 10131.7 10155.5 05:07:46 INFO - PID 3519 | -------- Summary: end -------- 05:07:46 INFO - PID 3519 | 05:07:47 INFO - TEST-INFO | 3519: exit 0 05:07:47 INFO - TEST-OK | dromaeo_css | took 1120120ms 05:07:47 INFO - TEST-START | kraken 05:07:47 INFO - operating with platform_type : linux_ 05:07:47 INFO - Initialising browser for kraken test... 05:07:47 INFO - TEST-INFO | started process 3840 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWBj2EJ/profile http://localhost:33746/getInfo.html) 05:07:51 INFO - PID 3840 | __metrics Screen width/height:1600/1200 05:07:51 INFO - PID 3840 | colorDepth:24 05:07:51 INFO - PID 3840 | Browser inner width/height: 1024/697 05:07:51 INFO - PID 3840 | __metrics 05:07:52 INFO - PID 3840 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:07:52 INFO - PID 3840 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:07:53 INFO - TEST-INFO | 3840: exit 0 05:07:53 INFO - Browser initialized. 05:07:53 INFO - Running cycle 1/1 for kraken test... 05:07:53 INFO - TEST-INFO | started process 3932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWBj2EJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:08:05 INFO - PID 3932 | RSS: Main: 144617472 05:08:05 INFO - PID 3932 | 05:08:07 INFO - PID 3932 | Cycle 1(1): loaded http://localhost:33746/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33746/tests/kraken/driver.html?testName=audio-beat-detection) 05:08:08 INFO - PID 3932 | RSS: Main: 199225344 05:08:08 INFO - PID 3932 | 05:08:11 INFO - PID 3932 | Cycle 1(1): loaded http://localhost:33746/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33746/tests/kraken/driver.html?testName=audio-dft) 05:08:11 INFO - PID 3932 | RSS: Main: 179159040 05:08:11 INFO - PID 3932 | 05:08:14 INFO - PID 3932 | Cycle 1(1): loaded http://localhost:33746/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33746/tests/kraken/driver.html?testName=audio-fft) 05:08:15 INFO - PID 3932 | RSS: Main: 260874240 05:08:15 INFO - PID 3932 | 05:08:17 INFO - PID 3932 | Cycle 1(1): loaded http://localhost:33746/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33746/tests/kraken/driver.html?testName=audio-oscillator) 05:08:18 INFO - PID 3932 | RSS: Main: 171098112 05:08:18 INFO - PID 3932 | 05:08:20 INFO - PID 3932 | Cycle 1(1): loaded http://localhost:33746/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33746/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:08:20 INFO - PID 3932 | RSS: Main: 176267264 05:08:20 INFO - PID 3932 | 05:08:23 INFO - PID 3932 | Cycle 1(1): loaded http://localhost:33746/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33746/tests/kraken/driver.html?testName=imaging-darkroom) 05:08:24 INFO - PID 3932 | RSS: Main: 214949888 05:08:24 INFO - PID 3932 | 05:08:27 INFO - PID 3932 | Cycle 1(1): loaded http://localhost:33746/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33746/tests/kraken/driver.html?testName=imaging-desaturate) 05:08:28 INFO - PID 3932 | RSS: Main: 224882688 05:08:28 INFO - PID 3932 | 05:08:31 INFO - PID 3932 | Cycle 1(1): loaded http://localhost:33746/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33746/tests/kraken/driver.html?testName=json-parse-financial) 05:08:31 INFO - PID 3932 | RSS: Main: 233091072 05:08:31 INFO - PID 3932 | 05:08:33 INFO - PID 3932 | Cycle 1(1): loaded http://localhost:33746/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33746/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:08:33 INFO - PID 3932 | RSS: Main: 177512448 05:08:33 INFO - PID 3932 | 05:08:35 INFO - PID 3932 | Cycle 1(1): loaded http://localhost:33746/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33746/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:08:36 INFO - PID 3932 | RSS: Main: 184442880 05:08:36 INFO - PID 3932 | 05:08:38 INFO - PID 3932 | Cycle 1(1): loaded http://localhost:33746/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33746/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:08:38 INFO - PID 3932 | RSS: Main: 193933312 05:08:38 INFO - PID 3932 | 05:08:41 INFO - PID 3932 | Cycle 1(1): loaded http://localhost:33746/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33746/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:08:42 INFO - PID 3932 | RSS: Main: 203714560 05:08:42 INFO - PID 3932 | 05:08:45 INFO - PID 3932 | Cycle 1(1): loaded http://localhost:33746/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33746/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:08:45 INFO - PID 3932 | RSS: Main: 199700480 05:08:45 INFO - PID 3932 | 05:08:47 INFO - PID 3932 | Cycle 1(1): loaded http://localhost:33746/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33746/tests/kraken/driver.html?testName=ai-astar) 05:08:47 INFO - PID 3932 | RSS: Main: 268152832 05:08:47 INFO - PID 3932 | 05:08:47 INFO - PID 3932 | __start_tp_report 05:08:47 INFO - PID 3932 | _x_x_mozilla_page_load 05:08:47 INFO - PID 3932 | _x_x_mozilla_page_load_details 05:08:47 INFO - PID 3932 | |i|pagename|runs| 05:08:47 INFO - PID 3932 | |0;ai-astar;101;109;109;109;108;109;109;109;108;110 05:08:47 INFO - PID 3932 | |1;audio-beat-detection;147;122;123;157;129;121;125;123;150;119 05:08:47 INFO - PID 3932 | |2;audio-dft;162;163;163;164;163;162;163;164;164;163 05:08:47 INFO - PID 3932 | |3;audio-fft;74;75;74;107;75;76;75;75;100;75 05:08:47 INFO - PID 3932 | |4;audio-oscillator;83;83;106;82;83;83;103;83;83;109 05:08:47 INFO - PID 3932 | |5;imaging-gaussian-blur;114;113;114;114;114;114;114;114;113;114 05:08:47 INFO - PID 3932 | |6;imaging-darkroom;148;148;148;148;147;148;147;148;148;147 05:08:47 INFO - PID 3932 | |7;imaging-desaturate;94;94;94;94;95;94;94;95;95;94 05:08:47 INFO - PID 3932 | |8;json-parse-financial;46;47;47;46;47;47;47;47;48;46 05:08:47 INFO - PID 3932 | |9;json-stringify-tinderbox;55;55;56;55;55;56;55;55;56;55 05:08:47 INFO - PID 3932 | |10;stanford-crypto-aes;87;83;82;81;82;81;80;81;80;81 05:08:47 INFO - PID 3932 | |11;stanford-crypto-ccm;134;135;127;130;128;135;131;127;169;157 05:08:47 INFO - PID 3932 | |12;stanford-crypto-pbkdf2;185;187;193;186;188;189;184;192;183;185 05:08:47 INFO - PID 3932 | |13;stanford-crypto-sha256-iterative;65;68;67;65;65;67;66;65;64;67 05:08:47 INFO - PID 3932 | __end_tp_report 05:08:47 INFO - PID 3932 | __start_cc_report 05:08:47 INFO - PID 3932 | _x_x_mozilla_cycle_collect,1729 05:08:47 INFO - PID 3932 | __end_cc_report 05:08:47 INFO - PID 3932 | __startTimestamp1491134927848__endTimestamp 05:08:47 INFO - PID 3932 | 05:08:47 INFO - PID 3932 | ------- Summary: start ------- 05:08:47 INFO - PID 3932 | Number of tests: 14 05:08:47 INFO - PID 3932 | 05:08:47 INFO - PID 3932 | [#0] ai-astar Cycles:10 Average:108.10 Median:109.00 stddev:2.56 (2.3%) stddev-sans-first:0.60 05:08:47 INFO - PID 3932 | Values: 101.0 109.0 109.0 109.0 108.0 109.0 109.0 109.0 108.0 110.0 05:08:47 INFO - PID 3932 | 05:08:47 INFO - PID 3932 | [#1] audio-beat-detection Cycles:10 Average:131.60 Median:127.00 stddev:14.07 (11.1%) stddev-sans-first:13.78 05:08:47 INFO - PID 3932 | Values: 147.0 122.0 123.0 157.0 129.0 121.0 125.0 123.0 150.0 119.0 05:08:47 INFO - PID 3932 | 05:08:47 INFO - PID 3932 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.00 stddev:0.74 (0.5%) stddev-sans-first:0.67 05:08:47 INFO - PID 3932 | Values: 162.0 163.0 163.0 164.0 163.0 162.0 163.0 164.0 164.0 163.0 05:08:47 INFO - PID 3932 | 05:08:47 INFO - PID 3932 | [#3] audio-fft Cycles:10 Average:80.60 Median:75.00 stddev:12.19 (16.3%) stddev-sans-first:12.70 05:08:47 INFO - PID 3932 | Values: 74.0 75.0 74.0 107.0 75.0 76.0 75.0 75.0 100.0 75.0 05:08:47 INFO - PID 3932 | 05:08:47 INFO - PID 3932 | [#4] audio-oscillator Cycles:10 Average:89.80 Median:83.00 stddev:11.27 (13.6%) stddev-sans-first:11.68 05:08:47 INFO - PID 3932 | Values: 83.0 83.0 106.0 82.0 83.0 83.0 103.0 83.0 83.0 109.0 05:08:47 INFO - PID 3932 | 05:08:47 INFO - PID 3932 | [#5] imaging-gaussian-blur Cycles:10 Average:113.80 Median:114.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:08:47 INFO - PID 3932 | Values: 114.0 113.0 114.0 114.0 114.0 114.0 114.0 114.0 113.0 114.0 05:08:47 INFO - PID 3932 | 05:08:47 INFO - PID 3932 | [#6] imaging-darkroom Cycles:10 Average:147.70 Median:148.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 05:08:47 INFO - PID 3932 | Values: 148.0 148.0 148.0 148.0 147.0 148.0 147.0 148.0 148.0 147.0 05:08:47 INFO - PID 3932 | 05:08:47 INFO - PID 3932 | [#7] imaging-desaturate Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 05:08:47 INFO - PID 3932 | Values: 94.0 94.0 94.0 94.0 95.0 94.0 94.0 95.0 95.0 94.0 05:08:47 INFO - PID 3932 | 05:08:47 INFO - PID 3932 | [#8] json-parse-financial Cycles:10 Average:46.80 Median:47.00 stddev:0.63 (1.3%) stddev-sans-first:0.60 05:08:47 INFO - PID 3932 | Values: 46.0 47.0 47.0 46.0 47.0 47.0 47.0 47.0 48.0 46.0 05:08:47 INFO - PID 3932 | 05:08:47 INFO - PID 3932 | [#9] json-stringify-tinderbox Cycles:10 Average:55.30 Median:55.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 05:08:47 INFO - PID 3932 | Values: 55.0 55.0 56.0 55.0 55.0 56.0 55.0 55.0 56.0 55.0 05:08:47 INFO - PID 3932 | 05:08:47 INFO - PID 3932 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:81.50 stddev:2.04 (2.5%) stddev-sans-first:0.97 05:08:47 INFO - PID 3932 | Values: 87.0 83.0 82.0 81.0 82.0 81.0 80.0 81.0 80.0 81.0 05:08:47 INFO - PID 3932 | 05:08:47 INFO - PID 3932 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:134.50 stddev:14.17 (10.5%) stddev-sans-first:14.97 05:08:47 INFO - PID 3932 | Values: 134.0 135.0 127.0 130.0 128.0 135.0 131.0 127.0 169.0 157.0 05:08:47 INFO - PID 3932 | 05:08:47 INFO - PID 3932 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.20 Median:187.50 stddev:3.33 (1.8%) stddev-sans-first:3.43 05:08:47 INFO - PID 3932 | Values: 185.0 187.0 193.0 186.0 188.0 189.0 184.0 192.0 183.0 185.0 05:08:47 INFO - PID 3932 | 05:08:47 INFO - PID 3932 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.50 stddev:1.29 (1.9%) stddev-sans-first:1.32 05:08:47 INFO - PID 3932 | Values: 65.0 68.0 67.0 65.0 65.0 67.0 66.0 65.0 64.0 67.0 05:08:47 INFO - PID 3932 | -------- Summary: end -------- 05:08:47 INFO - PID 3932 | 05:08:48 INFO - TEST-INFO | 3932: exit 0 05:08:48 INFO - TEST-OK | kraken | took 61466ms 05:08:48 INFO - SUITE-END | took 1181s 05:08:49 INFO - Completed test suite (00:19:41) 05:08:49 INFO - javascript benchmark 05:08:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7606.593533629097, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3364.2262279675674, 3389.220479289762, 3402.8979130626076, 3420.025292791555, 3437.0548099272696, 5754.0, 5805.187273781674, 5960.046392577188, 5984.700764961751, 5993.700314984249, 5772.740226689799, 5818.8254352369495, 5822.0, 5825.970870145643, 5838.124281357798, 5233.03188910051, 5268.236105764662, 5314.76083576238, 5327.547158491533, 5344.22508736233, 5356.38401583819, 5385.057614917393, 5392.460753924615, 5396.811111611094, 5398.16328469086, 5246.108161612516, 5262.131748261551, 5440.945590544104, 5447.373552041527, 5457.727113644302, 5077.289179514871, 5299.5760339172775, 5333.253344531769, 5380.811671591476, 5394.271773310592, 5098.59211263098, 5113.872153196163, 5156.020356132361, 5162.6128040397125, 5170.1986192140275, 5791.102379131242, 5881.6471011739, 5949.9107513387335, 5960.225170727777, 5998.1602575639445, 6436.485081193493, 6474.384933431316, 6477.514186435989, 6478.967605161991, 6480.351964803529, 6514.511411644098, 6524.282328943812, 6529.706163222666, 6536.248331441898, 6540.411362977355, 5786.971065144648, 5799.130130480462, 6028.97507423739, 6030.155778191057, 6033.517318614544, 6344.365563443619, 6543.0, 6552.737890484327, 6607.141071660653, 6629.734810607618, 6304.779332723333, 6310.747570097236, 6312.147860038928, 6317.905231421532, 6327.96836015817, 6133.938660613426, 6151.507879369639, 6161.537884658668, 6428.485721142298, 6450.097221319722, 6318.210223722035, 6412.4549413299455, 6421.935780642134, 6424.518161137933, 6431.646259455775, 6452.548321617442, 6452.741890324428, 6457.677116144174, 6458.095866578683, 6460.25707043696, 4697.600703940203, 4891.828785992473, 4892.877678058077, 4896.730679812573, 4943.406791185081, 4172.4993000840095, 4270.0605866709275, 4330.28550289205, 4335.0, 4340.370646256275, 6042.395760423922, 6075.088736689532, 6101.816945491642, 6103.023516237381, 6105.725242364104, 6494.1232933553365, 6504.056911747864, 6510.739570417225, 6511.0, 6511.609303441809, 5792.189093526909, 5898.8820223595285, 5899.321578018583, 5901.380355062656, 5994.400559944058, 5314.813981510629, 5339.225812257201, 5339.225812257201, 5339.385970613352, 5340.19897015443, 6432.163818703539, 6454.548181627241, 6576.638284894281, 6644.60132392058, 6669.0, 6464.612123272619, 6488.0, 6532.183477065367, 6533.803985880431, 6536.3136870629805, 6690.096836927147, 6707.832304192434, 6709.0, 6731.158605174353, 6732.461403087839, 6073.149759033827, 6099.128199784669, 6233.314335423191, 6397.200349956255, 6404.903926441014, 6406.23125224976, 6426.871462570816, 6440.098386225838, 6440.645764482999, 6448.2262128543, 6332.271788744353, 6335.683215839097, 6335.904961425675, 6338.461230795434, 6339.90490142639, 6025.0661147522205, 6325.304216536086, 6326.810195694136, 6331.90502142459, 6337.0, 6195.1636529068, 6269.937300626935, 6270.372962703693, 6274.058891166362, 6276.0, 6343.365663433619, 6350.142730731477, 6362.586431881913, 6364.268109167505, 6367.586106903036, 5800.970995144998, 5979.0, 6165.136880836776, 6168.444839964245, 6177.6911154441195], "value": 5861.599573497146, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [754.9924500754994, 805.4885147931063, 829.7178959153888, 1130.3048625095564, 1146.6273461125136, 31802.36395272096, 32259.51610725835, 32449.188770280754, 32485.67514324856, 32503.187420314443, 38896.41655375172, 39156.412653810214, 39442.211155776866, 39647.0, 39772.40341394874, 8249.79375515611, 8399.160083991583, 8412.242898139166, 8413.873791893096, 8414.621342039592, 6130.1111338855835, 6307.526935479835, 8106.837863242761, 8247.298979586712, 8391.286740627054, 8244.793880152984, 8425.157484251587, 8436.072032076467, 8439.915600843975, 8442.366822488308, 8451.74644760655, 8519.616617252177, 8525.062243153248, 8530.146985301482, 8536.402451828406, 6086.817395478142, 6252.437280644764, 7827.099883513355, 7910.0, 7924.286814186693, 38614.80692596519, 38910.61089389098, 38919.8054009731, 38926.61073389258, 38960.41559376611, 2954.3057381515328, 2962.614860068177, 2967.9554806677916, 2978.776591755627, 2987.671356150822, 28589.142325730263, 28651.283717907012, 28822.279443013882, 28877.27806804847, 28986.42027159445, 3632.4732913727626, 3655.9268814623824, 3668.3763760160837, 3682.6317368263226, 3737.3085979093953, 219689.90155049282, 220810.0, 221635.0, 221926.0, 222838.0, 48728.75635621799, 48765.512344876806, 48847.313397763464, 48922.51077489251, 48943.755281224076, 50469.0, 50713.74643126761, 50719.746401268494, 50758.0, 50774.74612626913, 14005.439782408794, 14247.358868850926, 14276.928615356857, 14276.928615357065, 14278.928605357114, 11202.327860328407, 11205.103591712643, 11242.100631949588, 11249.156313276537, 11254.49354779037, 12108.183772434206, 12324.50701971911, 13569.660758480919, 13611.727765444635, 14295.0, 5205.323307969939, 5271.446498117719, 5307.814226502054, 5349.679019258857, 5356.1697936819855, 1039.2880876599402, 1059.692689120162, 1069.3102948598112, 1074.5433190893839, 1103.3765922253901, 25234.116805911704, 25347.873260633947, 25466.745332546438, 25557.3610659735, 25785.226443206735, 1124.960626378073, 1144.6165534545853, 1154.2093665838927, 1158.2297771981707, 1172.3259126002413, 13310.933445332712, 13335.866641333656, 13370.46518139283, 13516.797248041286, 13569.321533923265, 304483.0, 304902.0, 305026.0, 305223.0, 305960.0, 51226.23160652593, 51263.0, 51395.0, 51437.74281128645, 51527.484725153015, 1434.3545404567985, 1462.1884853905972, 1468.7649976003788, 1469.9853001470062, 1504.653929596199, 24046.27861164168, 29092.709072909, 29415.0, 30785.230369240948, 30887.382252355277, 49488.50511494839, 49596.50403495919, 49802.50197497979, 49814.0, 49856.501434985184, 263637.0, 264201.0, 265031.0, 266002.0, 266220.0, 32588.83705581457, 32966.0, 32985.0, 33060.66939330576, 33157.33685326328, 41158.794206028775, 41179.0, 41212.793936030124, 41297.79351103225, 41313.79343103265, 30493.54259686151, 30639.846800765852, 30872.53691194589, 31149.532757008208, 31821.681783181873, 31255.374892502477, 31367.686323136477, 31693.683063169072, 31734.68265317317, 32475.863344782818, 35858.8207058963, 36289.27421451609, 36407.81796091109, 37027.444588330654, 37387.81306093561, 30245.848770756005, 30634.540481893237, 30906.53640195444, 31572.36855262928, 33463.66536334605, 26548.82297951881, 26675.333116671463, 26816.463670726866, 26887.0, 27168.049118280764], "value": 17372.283929637713, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.2003073668242, 418.7934759383682, 426.6330955378375, 441.67095513842185, 443.25311849533557, 17924.731129033058, 21142.57714845704, 22230.777692223073, 22303.44241393964, 22420.439489012784, 21043.789562104375, 21999.12003519857, 22029.66955495669, 22204.55590888181, 22540.21109261176, 5191.325127733389, 5529.723513824313, 6035.215421995145, 6162.969185154068, 6195.28754193269, 6054.757809687607, 6083.452489275965, 6083.48290395317, 6087.995480745672, 6088.726007329681, 5945.078512830518, 6035.5473339499495, 6044.667543285118, 6085.847853803668, 6088.878222435548, 5934.406559344075, 6093.542984276175, 6094.6343219406535, 6125.601835880676, 6140.201773769404, 5478.808241711561, 5532.30846144232, 5536.197251398565, 5536.75084621193, 5537.224788529609, 25876.0, 25925.870370648216, 26002.349941251432, 26445.867770661214, 26540.469190616273, 1979.1388071676943, 1982.7422435083347, 1983.8412926965952, 2000.3498862869626, 2088.7389076365453, 15460.845391546052, 16264.837351626451, 16411.17944102802, 16596.668066638722, 16889.91555042229, 2102.3062389411457, 2147.516808718026, 2148.4951036506563, 2153.3001774423374, 2156.4608847788054, 112867.43566282198, 113859.21322981697, 113991.99999999917, 114283.0, 114485.4275728616, 11205.870884531912, 11741.823872641917, 12099.213551119148, 12138.696532586579, 12316.261024338568, 17112.401065962633, 17353.3058677654, 17408.0, 17448.214830332665, 17546.947183168795, 8436.282915952213, 8471.279941205066, 8686.218240358272, 8802.735917922473, 8846.823063538694, 7945.364370850318, 8020.8369786380645, 8031.156728543536, 8207.753767386988, 8238.8352232955, 7762.301392874669, 7807.813812132612, 7822.491538050009, 7980.760577182694, 8067.757967260992, 2116.8200702940117, 2183.945401364947, 2200.6368949123216, 2220.3006053093222, 2272.5454909018263, 1004.372267332917, 1009.9040591143829, 1026.9948650256702, 1030.3302853145515, 1033.1992705653179, 20576.69134962947, 20830.895845520674, 20977.685334719685, 21090.47273818136, 21162.682559761615, 1020.454057079459, 1055.6094245129352, 1057.318029870729, 1066.2429674930886, 1085.7882712870914, 10063.345882517613, 11149.386783726974, 11168.832467512993, 11261.099112071015, 11275.267107637977, 634611.0, 640194.0, 646082.0, 662739.0, 679284.0, 105995.0, 111165.44417278023, 111978.44010780058, 117495.43829829917, 118087.0, 1206.7538321914024, 1212.4059210986552, 1267.5310135250202, 1270.0411189551828, 1272.0, 19889.701654475484, 20312.695309570663, 20945.89527052355, 21051.8947405262, 21087.15651373928, 49507.25739113844, 50621.746891265306, 51028.74485627548, 51308.48691513037, 51413.485865142364, 64977.35022649713, 66331.0, 66370.66814665895, 68360.6581967087, 70615.64692176506, 9345.48599827016, 9351.111644393772, 9558.713238602853, 9575.664851730156, 9617.951910240405, 15488.148151851756, 15864.762028569812, 15979.28352180109, 16087.678246434773, 16102.516924492284, 13180.604581862559, 13310.0, 13362.665933351744, 13511.729765404834, 13556.457741690616, 12443.191192572454, 12615.0, 12764.361781911053, 12966.80549791735, 13077.607671769862, 12544.686382840502, 13727.0, 13892.72214555683, 13932.721345573234, 14483.927580362451, 9381.484018379055, 9456.763580910532, 9613.951930240304, 9659.32384733062, 10151.289409741246, 13135.671608209872, 13262.336883155996, 13430.261335626634, 13598.320083995563, 13765.040516289046], "value": 10485.825167480714, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.6033159886233, 1341.6981179234674, 1361.63916562111, 1371.5748118083402, 1383.757842377584, 10313.432761198132, 10751.193660475466, 10753.30103543269, 10759.78480430392, 10761.62334318299, 10440.895591044087, 10661.093807026393, 10965.61620343288, 10980.670579882597, 10983.890161098387, 2329.9417514562147, 2369.9881500592473, 2371.6679664846934, 2372.7508611595795, 2373.750756170603, 1981.3659628918751, 2264.513129677119, 2366.183666635017, 2373.3473294843884, 2375.2517956843626, 2037.6841589553642, 2281.292799232235, 2340.8244381671443, 2353.1999120299097, 2361.2207971369407, 2272.874991875446, 2301.7007788987407, 2338.2634470141934, 2339.853471798823, 2343.4961483281177, 2317.073170731721, 2326.3718795925006, 2327.697399338092, 2327.883605819702, 2327.953440931172, 11131.0, 11198.720031999184, 11217.551297948072, 11231.550737970472, 11237.494312755945, 5950.672713000783, 6010.3689112643415, 6117.113018612276, 6144.477719393813, 6144.846378840565, 3589.6051434342203, 3647.361711700442, 3819.5416550013897, 3840.577536470986, 3880.825362858678, 1312.4815697799315, 1377.6280404290785, 1408.4647833823185, 1414.5190635184088, 1441.0561082490985, 15689.764653530206, 15735.76396354067, 15790.368385264575, 15909.681806363924, 15922.044677319282, 4943.134951383494, 5226.738663066832, 5279.9208011879855, 5295.894082118336, 5358.303420555303, 12459.19015264023, 12478.251304921734, 12487.375631218403, 12495.687607809878, 12496.87503124957, 6153.138560601519, 6165.260168779775, 6173.228346456693, 6177.4749146323065, 6181.381861813873, 5378.97310513445, 5648.181013752983, 5693.971530142406, 5703.7148142592705, 5712.457316554921, 3803.448499967489, 3969.9753125905995, 4018.9799051005143, 4033.1933613276874, 4043.7775922324554, 1054.8048611006989, 1164.231607139284, 1185.887340702632, 1186.887245711656, 1197.2577002258656, 730.8063363208754, 815.6207363575847, 844.7803571071443, 845.9957700211583, 852.4544291653347, 6781.694823732944, 7173.92826071743, 7240.2035776064595, 7241.818954526179, 7247.347738703542, 960.558143254111, 964.7298756348234, 967.6419724701906, 981.2983716642492, 990.4750482244422, 4235.435075632757, 4438.822447102079, 4467.15124126415, 4470.687051906335, 4632.745199014086, 14258.42966281337, 14333.78499322511, 14409.414964353913, 14875.47935822241, 14886.0, 14372.137671739729, 14383.78424323636, 14395.640108997359, 14465.13209207451, 14475.638109047148, 9863.0, 10053.69838904834, 10068.34555753859, 10077.193824494023, 10079.647212347532, 6417.679116044273, 6440.742370305135, 6452.580582262138, 6488.0, 6541.836454088686, 12253.264804111783, 12297.200681955645, 12327.321997290235, 12373.195742276723, 12385.690357741129, 12345.074119440898, 12413.503459861504, 12521.624351269476, 12563.057770667054, 12706.428210730355, 9158.542072896194, 9431.434113953184, 9442.10300021497, 9451.574679139592, 9469.905300946903, 10149.695509134737, 10201.183905287411, 10228.897711022795, 10388.32475889095, 10421.635242766466, 8604.698835540727, 8752.081031491602, 8839.116088391109, 8951.283897288331, 9061.275097992013, 8279.468298364822, 8364.3726720495, 8398.328133749408, 8418.074011858569, 8427.115152909102, 7772.961135194288, 7810.88283675734, 7853.646585903533, 7858.489198202098, 7892.171322011336, 5627.127795191752, 5728.169415434655, 5798.0, 5910.0, 5943.732532036155, 5924.229850119457, 5955.196048533393, 5961.940380596138, 6003.129546215861, 6182.907256391248], "value": 5206.347607466981, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.89547665345333, 410.21034508570995, 411.5719651562375, 411.77764007435985, 425.3810705423607, 6024.548158888079, 6036.9776124998125, 6039.674725230785, 6042.395760423956, 6046.758129674808, 5770.884582308362, 5890.410958904107, 5932.169496270515, 5948.0, 5956.821295361146, 4621.0, 4641.280601506755, 4648.093621743761, 4649.51180126087, 4672.509386514401, 4502.144592527426, 4619.475573060899, 4627.074585082997, 4629.629629629639, 4667.0, 4573.039661671053, 4576.057857513893, 4611.100835337111, 4612.308153776927, 4634.21218392874, 4594.74728889911, 4596.494385617596, 4599.9080018399445, 4613.907721845578, 4623.2371658676275, 4156.334986402191, 4184.581541845791, 4190.706650534464, 4198.706090573661, 4198.958010419888, 5572.275604171472, 5741.483266506035, 5786.537077033827, 5794.710264486759, 5805.390434004411, 5294.258803767476, 5314.229436731691, 5319.148936170194, 5324.600654950856, 5334.546563542103, 5979.790707325266, 6191.81424557264, 6276.87446251077, 6286.49708023357, 6290.811275661737, 4449.887528117971, 4450.0, 4452.287633978548, 4453.977730111329, 4457.598816106533, 6234.937650623481, 6414.390632889868, 6537.836554086139, 6617.205935287748, 6619.371159739817, 4475.328700694857, 4501.347304640874, 4535.274356103074, 4537.75042372666, 4541.3869127668, 4621.168189725881, 4626.21354369758, 4627.514111018362, 4638.257878739386, 4638.466576343696, 5014.924776128361, 5052.863105801165, 5271.0, 5320.893582128336, 5325.547328477045, 6173.506119510518, 6272.466840318532, 6285.528585356116, 6316.873662526816, 6330.39861213184, 1574.6457047164527, 1579.778830963666, 1590.5784966983758, 1602.6233835048754, 1603.2224371179968, 1049.3651340938623, 1072.8551645527755, 1073.7637719701654, 1082.8105081610686, 1096.819024860905, 6065.269859036661, 6065.636061836216, 6070.180525629072, 6070.969645151834, 6080.027195648675, 6244.0, 6492.967535162388, 6532.346765323429, 6534.313897040837, 6559.048428207326, 6057.909131363033, 6080.361562036011, 6085.604435711664, 6087.269527656709, 6095.878082438327, 3415.692587667072, 3423.9315213695586, 3426.194844211608, 3441.6577534761464, 3446.4313388291152, 6566.835829104215, 6609.933900661028, 6663.333666633298, 6694.430973367221, 6698.296678848748, 6587.571807832475, 6598.0, 6610.0, 6620.768273110418, 6631.171103612049, 6467.126937863328, 6569.37590928861, 6583.868322633425, 6624.238212605515, 6724.4284235840505, 6390.936090639034, 6417.625478572958, 6420.839479013062, 6475.287718351072, 6496.0, 6216.689165541795, 6342.79486897488, 6396.776112836028, 6427.228732551936, 6434.742610295723, 6361.554691171574, 6510.902336464862, 6535.771248006297, 6688.3646053624825, 6717.630530320879, 4828.720389096822, 4890.951090489049, 4903.387076615423, 4936.086823937583, 4941.481144479778, 6348.42864142211, 6456.806295811133, 6518.0, 6519.608823470607, 6532.0, 6314.684265786784, 6315.273743519554, 6321.399467050623, 6326.335734747785, 6366.172397588469, 6320.431161195331, 6321.52588555851, 6330.525210609315, 6350.333215012357, 6360.8868448020485, 6095.908561371672, 6279.874402511833, 6303.306636269915, 6315.652639104709, 6323.272823625342, 6348.174737284124, 6349.238091429058, 6353.936460635519, 6358.491320694426, 6387.393197646216, 5982.4316689914385, 6126.724297406717, 6175.382461753788, 6181.0, 6205.625034350682], "value": 4808.073476104048, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [735.588070680419, 737.1007371007375, 743.1194035068444, 755.1504557372955, 757.8635845547802, 15954.361825526965, 16833.15834208288, 16836.83163168368, 16843.74734378985, 16845.32618695251, 15521.844781552181, 15536.689266214697, 15633.687326253468, 15683.764743528856, 15720.292586833591, 862.2756884217272, 888.5379602606673, 889.4796544021755, 891.0065277215922, 898.1198425542972, 955.7419496735877, 957.3203025851653, 960.0687333286701, 960.7550074730934, 961.423146112334, 1006.0945149365556, 1008.334499230508, 1012.9341592796445, 1013.1287093099928, 1013.3160116921085, 995.7062666513395, 996.6810620601374, 997.9700608981669, 998.4009594243469, 998.670438755209, 730.8246020954986, 734.0237484146127, 735.2647352647352, 735.4851603877307, 736.2600586410676, 14639.19484428356, 14939.551813445614, 14958.252087395587, 15010.24948752558, 15070.321835517429, 12734.363281835871, 13001.739965200737, 13480.191188528719, 13491.123077000062, 13513.662158446019, 11460.484278207417, 11488.712782180428, 11542.538298468051, 11680.707982300426, 11784.882151178464, 3007.6541197762317, 3017.0948715385516, 3039.012320995685, 3082.676318986519, 3085.41377138343, 83459.5827020861, 84313.15686843176, 84775.57612211962, 85119.57440212822, 85211.57394213052, 9352.859707104399, 9389.953050234704, 9462.858057129148, 9470.100340467645, 9600.471974041355, 18589.349372772158, 18616.720749188775, 18752.437426877215, 18763.34328298503, 19033.333833316043, 7949.960250198712, 7998.5600791957, 8005.559694216758, 8119.675212991532, 8279.58602069894, 4200.7675821163575, 4252.978735106367, 4337.240982828055, 4344.9565504344555, 4372.344148377769, 4130.359794231899, 4131.091159944807, 4201.34879093741, 4204.579542045833, 4205.2640787862, 727.0185249912681, 732.6739600877559, 746.2723844251811, 754.1327473405628, 760.7869796457001, 601.8766152938724, 614.1800696070795, 628.7296462521068, 633.5944995203074, 646.7025168422484, 10560.0, 10817.188710846718, 11011.28426652265, 11114.444277786079, 11202.887971120184, 627.6108812536256, 642.6658137768334, 652.8563715982476, 653.9673016349163, 654.9115869357671, 4636.884077898079, 4814.325994360793, 4833.758312084382, 4863.489333619989, 4866.562009419169, 75079.0, 77087.0, 77549.61225193951, 78709.60645196852, 79977.20022799697, 64961.67519162469, 66809.0, 67346.66326668335, 67427.3257267421, 68316.0, 57837.71081144567, 58580.0, 59132.704336478906, 59502.70248648729, 60630.696846516366, 10964.451777410937, 11372.829407559058, 11476.770464590494, 11519.0, 11615.245009074382, 31574.0, 32868.83565582157, 32928.83535582307, 32965.34069318648, 33001.339973200884, 39396.0, 39953.60046399499, 40021.0, 40275.3958690614, 40741.0, 13059.412326445143, 13214.0, 13247.536336228572, 13382.13016153947, 13542.390592423562, 14510.637234069232, 14562.92718536443, 14607.19660418687, 14663.706725865637, 14764.852351476347, 14670.193139377438, 14792.852071479147, 14844.109353438827, 14853.108813471226, 14968.101913885203, 14202.715945681235, 14313.427462901784, 14606.196659183846, 15204.239788010334, 15229.0, 14490.782638260645, 14726.779098313747, 14787.482438115045, 15397.307121179798, 15415.226725311712, 10120.949395252977, 10458.99733158424, 10867.891321087005, 10929.890701092887, 11039.668809935714, 9698.0, 10123.0, 10129.797404051731, 10131.696049118538, 10155.492225388849], "value": 7246.523710535166, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1503.2999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 109.0, 109.0, 108.0, 109.0, 109.0, 109.0, 108.0, 110.0], "value": 108.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 122.0, 123.0, 157.0, 129.0, 121.0, 125.0, 123.0, 150.0, 119.0], "value": 131.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 163.0, 164.0, 163.0, 162.0, 163.0, 164.0, 164.0, 163.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 74.0, 107.0, 75.0, 76.0, 75.0, 75.0, 100.0, 75.0], "value": 80.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 106.0, 82.0, 83.0, 83.0, 103.0, 83.0, 83.0, 109.0], "value": 89.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 148.0, 148.0, 147.0, 148.0, 147.0, 148.0, 148.0, 147.0], "value": 147.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 95.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [46.0, 47.0, 47.0, 46.0, 47.0, 47.0, 47.0, 47.0, 48.0, 46.0], "value": 46.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 56.0, 55.0, 55.0, 56.0, 55.0, 55.0, 56.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 82.0, 81.0, 82.0, 81.0, 80.0, 81.0, 80.0, 81.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 127.0, 130.0, 128.0, 135.0, 131.0, 127.0, 169.0, 157.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 187.0, 193.0, 186.0, 188.0, 189.0, 184.0, 192.0, 183.0, 185.0], "value": 187.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 67.0, 65.0, 65.0, 67.0, 66.0, 65.0, 64.0, 67.0], "value": 65.9, "unit": "score"}]}]} 05:08:49 INFO - Return code: 0 05:08:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:08:49 ERROR - # TBPL SUCCESS # 05:08:49 INFO - Running post-action listener: _resource_record_post_action 05:08:49 INFO - [mozharness: 2017-04-02 12:08:49.171319Z] Finished run-tests step (success) 05:08:49 INFO - Running post-run listener: _resource_record_post_run 05:08:49 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 7434240; Write bytes: 370884608; Read time: 1996; Write time: 229656 05:08:49 INFO - TinderboxPrint: CPU usage
13.0% 05:08:49 INFO - TinderboxPrint: I/O read bytes / time
7,434,240 / 1,996 05:08:49 INFO - TinderboxPrint: I/O write bytes / time
370,884,608 / 229,656 05:08:49 INFO - TinderboxPrint: CPU idle
8,326.2 (87.0%) 05:08:49 INFO - TinderboxPrint: CPU user
1,192.6 (12.5%) 05:08:49 INFO - TinderboxPrint: Swap in / out
0 / 0 05:08:49 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 4096; Write bytes: 111869952; Read time: 144; Write time: 80260 05:08:49 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 5107712; Write bytes: 258650112; Read time: 1376; Write time: 149368 05:08:49 INFO - Running post-run listener: _upload_blobber_files 05:08:49 INFO - Blob upload gear active. 05:08:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:08:49 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 05:08:49 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:08:49 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:08:50 INFO - (blobuploader) - INFO - Open directory for files ... 05:08:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:08:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:08:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:08:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:08:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:08:51 INFO - (blobuploader) - INFO - Done attempting. 05:08:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:08:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:08:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:08:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:08:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:08:51 INFO - (blobuploader) - INFO - Done attempting. 05:08:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:08:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:08:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:08:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:08:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:08:54 INFO - (blobuploader) - INFO - Done attempting. 05:08:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:08:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:08:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:08:56 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:08:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:08:56 INFO - (blobuploader) - INFO - Done attempting. 05:08:56 INFO - (blobuploader) - INFO - Iteration through files over. 05:08:56 INFO - Return code: 0 05:08:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:08:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:08:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10851f1b455c2a760f4ee2ad80457ea1786c3295d322f44647f845e080fbb4804a737e625e480f500fc48a65457a4cbab24e9d2073ee7dd98b9c4cc3bbb76bdf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba089aaa312281766970b97b35a14577fa60e2d216cdc3ac7353afcc03bdb975be4ff60ebc7ffe704e0495b0f3e51b0336bd1ee5688888dd68c53c1ccace6d57", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3e237c2a9e1f18b97daf317269a7256fd2ffae16a1ac33bcaa20fa09e236cb3e4fddd2470e80893aa6bcce96e68cea101b0b7821df675611766f16f6a9ef4cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/662c797ede3e24d700a6e2bcfff0ebb0bf5da74fc97ed500178069364bf3ea95a7ca7a68cdb8c7dc39c5548014f34f68fd739e41737adae180c1d58ed5451297"} 05:08:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:08:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:08:56 INFO - Contents: 05:08:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10851f1b455c2a760f4ee2ad80457ea1786c3295d322f44647f845e080fbb4804a737e625e480f500fc48a65457a4cbab24e9d2073ee7dd98b9c4cc3bbb76bdf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba089aaa312281766970b97b35a14577fa60e2d216cdc3ac7353afcc03bdb975be4ff60ebc7ffe704e0495b0f3e51b0336bd1ee5688888dd68c53c1ccace6d57", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3e237c2a9e1f18b97daf317269a7256fd2ffae16a1ac33bcaa20fa09e236cb3e4fddd2470e80893aa6bcce96e68cea101b0b7821df675611766f16f6a9ef4cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/662c797ede3e24d700a6e2bcfff0ebb0bf5da74fc97ed500178069364bf3ea95a7ca7a68cdb8c7dc39c5548014f34f68fd739e41737adae180c1d58ed5451297"} 05:08:56 INFO - Running post-run listener: copy_logs_to_upload_dir 05:08:56 INFO - Copying logs to upload dir... 05:08:56 INFO - mkdir: /builds/slave/test/build/upload/logs 05:08:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.831946 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-04-02 05:08:56.281316) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-02 05:08:56.285025) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761 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/sha512/10851f1b455c2a760f4ee2ad80457ea1786c3295d322f44647f845e080fbb4804a737e625e480f500fc48a65457a4cbab24e9d2073ee7dd98b9c4cc3bbb76bdf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba089aaa312281766970b97b35a14577fa60e2d216cdc3ac7353afcc03bdb975be4ff60ebc7ffe704e0495b0f3e51b0336bd1ee5688888dd68c53c1ccace6d57", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3e237c2a9e1f18b97daf317269a7256fd2ffae16a1ac33bcaa20fa09e236cb3e4fddd2470e80893aa6bcce96e68cea101b0b7821df675611766f16f6a9ef4cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/662c797ede3e24d700a6e2bcfff0ebb0bf5da74fc97ed500178069364bf3ea95a7ca7a68cdb8c7dc39c5548014f34f68fd739e41737adae180c1d58ed5451297"} build_url:https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011193 build_url: 'https://queue.taskcluster.net/v1/task/KOQdqULDTkGAcgX2SelByg/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/10851f1b455c2a760f4ee2ad80457ea1786c3295d322f44647f845e080fbb4804a737e625e480f500fc48a65457a4cbab24e9d2073ee7dd98b9c4cc3bbb76bdf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ba089aaa312281766970b97b35a14577fa60e2d216cdc3ac7353afcc03bdb975be4ff60ebc7ffe704e0495b0f3e51b0336bd1ee5688888dd68c53c1ccace6d57", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d3e237c2a9e1f18b97daf317269a7256fd2ffae16a1ac33bcaa20fa09e236cb3e4fddd2470e80893aa6bcce96e68cea101b0b7821df675611766f16f6a9ef4cb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/662c797ede3e24d700a6e2bcfff0ebb0bf5da74fc97ed500178069364bf3ea95a7ca7a68cdb8c7dc39c5548014f34f68fd739e41737adae180c1d58ed5451297"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-02 05:08:56.311224) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 05:08:56.311537) ========= 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=7fc86f70bae03e018da0b1d8000001c4-1491129167.317182-1107415761 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004365 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-02 05:08:56.395853) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-02 05:08:56.396157) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-02 05:08:56.396528) ========= ========= Total master_lag: 0.18 =========