builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs slave: talos-linux64-ix-003 starttime: 1491765210.4 results: success (0) revision: 45692c884fdd5136a64fb2f8a61a0c8183b69331 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-09 12:13:30.404584) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-09 12:13:30.405103) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-09 12:13:30.405426) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-09 12:13:30.459292) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:13:30.459669) ========= 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=7de08804244eb36560b44971000001c3-1491764897.971542-71221440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-09 12:13:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.1M=0s 2017-04-09 12:13:31 (46.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.161296 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:13:30.638110) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:13:30.638461) ========= 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=7de08804244eb36560b44971000001c3-1491764897.971542-71221440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023201 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:13:30.688749) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-09 12:13:30.689077) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 45692c884fdd5136a64fb2f8a61a0c8183b69331 --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 45692c884fdd5136a64fb2f8a61a0c8183b69331 --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=7de08804244eb36560b44971000001c3-1491764897.971542-71221440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-09 12:13:31,768 truncating revision to first 12 chars 2017-04-09 12:13:31,768 Setting DEBUG logging. 2017-04-09 12:13:31,768 attempt 1/10 2017-04-09 12:13:31,768 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/45692c884fdd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-09 12:13:33,222 unpacking tar archive at: mozilla-central-45692c884fdd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.837980 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-09 12:13:32.540219) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-09 12:13:32.540528) ========= script_repo_revision: 45692c884fdd5136a64fb2f8a61a0c8183b69331 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-09 12:13:32.540917) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-09 12:13:32.541190) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-09 12:13:32.550787) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-04-09 12:13:32.551180) ========= /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=7de08804244eb36560b44971000001c3-1491764897.971542-71221440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:13:33 INFO - MultiFileLogger online at 20170409 12:13:33 in /builds/slave/test 12:13:33 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 12:13:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:13:33 INFO - {'append_to_log': False, 12:13:33 INFO - 'base_work_dir': '/builds/slave/test', 12:13:33 INFO - 'blob_upload_branch': 'Firefox', 12:13:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:13:33 INFO - 'branch': 'Firefox', 12:13:33 INFO - 'buildbot_json_path': 'buildprops.json', 12:13:33 INFO - 'config_files': ('talos/linux_config.py',), 12:13:33 INFO - 'default_actions': ('clobber', 12:13:33 INFO - 'read-buildbot-config', 12:13:33 INFO - 'download-and-extract', 12:13:33 INFO - 'populate-webroot', 12:13:33 INFO - 'create-virtualenv', 12:13:33 INFO - 'install', 12:13:33 INFO - 'run-tests'), 12:13:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:13:33 INFO - 'download_minidump_stackwalk': True, 12:13:33 INFO - 'download_symbols': 'ondemand', 12:13:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:13:33 INFO - 'tooltool.py': '/tools/tooltool.py', 12:13:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:13:33 INFO - '/tools/misc-python/virtualenv.py')}, 12:13:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:13:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:13:33 INFO - 'gecko_profile': False, 12:13:33 INFO - 'gecko_profile_interval': 0, 12:13:33 INFO - 'installer_path': 'installer.exe', 12:13:33 INFO - 'log_level': 'info', 12:13:33 INFO - 'log_name': 'talos', 12:13:33 INFO - 'log_to_console': True, 12:13:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:13:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:13:33 INFO - 'opt_config_files': (), 12:13:33 INFO - 'pip_index': False, 12:13:33 INFO - 'suite': 'dromaeojs', 12:13:33 INFO - 'system_bits': '32', 12:13:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:13:33 INFO - 'title': 'talos-linux64-ix-003', 12:13:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:13:33 INFO - 'use_talos_json': True, 12:13:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:13:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:13:33 INFO - 'work_dir': 'build'} 12:13:33 INFO - [mozharness: 2017-04-09 19:13:33.730359Z] Running clobber step. 12:13:33 INFO - Running pre-action listener: _resource_record_pre_action 12:13:33 INFO - Running main action method: clobber 12:13:33 INFO - rmtree: /builds/slave/test/build 12:13:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:13:34 INFO - Running post-action listener: _resource_record_post_action 12:13:34 INFO - [mozharness: 2017-04-09 19:13:34.660215Z] Finished clobber step (success) 12:13:34 INFO - [mozharness: 2017-04-09 19:13:34.660315Z] Running read-buildbot-config step. 12:13:34 INFO - Running pre-action listener: _resource_record_pre_action 12:13:34 INFO - Running main action method: read_buildbot_config 12:13:34 INFO - Using buildbot properties: 12:13:34 INFO - { 12:13:34 INFO - "project": "", 12:13:34 INFO - "product": "firefox", 12:13:34 INFO - "who": "archaeopteryx@coole-files.de", 12:13:34 INFO - "installer_path": "public/build/target.tar.bz2", 12:13:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs", 12:13:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 12:13:34 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs", 12:13:34 INFO - "stage_platform": "linux64-stylo", 12:13:34 INFO - "basedir": "/builds/slave/test", 12:13:34 INFO - "buildnumber": 18, 12:13:34 INFO - "platform": "ubuntu64_hw_stylo", 12:13:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:13:34 INFO - "slavebuilddir": "test", 12:13:34 INFO - "taskId": "Ls_QN9erST-uxrE5mekMMQ", 12:13:34 INFO - "branch": "mozilla-central", 12:13:34 INFO - "script_repo_revision": "production", 12:13:34 INFO - "revision": "45692c884fdd5136a64fb2f8a61a0c8183b69331", 12:13:34 INFO - "slavename": "talos-linux64-ix-003", 12:13:34 INFO - "repo_path": "mozilla-central" 12:13:34 INFO - } 12:13:34 INFO - Finding installer, test and symbols from parent task. 12:13:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ls_QN9erST-uxrE5mekMMQ'}, attempt #1 12:13:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ls_QN9erST-uxrE5mekMMQ'}, attempt #1 12:13:35 INFO - Task dependencies: EDYNlfHKRrKT8I4EvF1W4Q 12:13:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EDYNlfHKRrKT8I4EvF1W4Q'}, attempt #1 12:13:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/EDYNlfHKRrKT8I4EvF1W4Q/artifacts/public/build/target.tar.bz2 12:13:36 INFO - Set test_url: https://queue.taskcluster.net/v1/task/EDYNlfHKRrKT8I4EvF1W4Q/artifacts/public/build/test_packages.json 12:13:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/EDYNlfHKRrKT8I4EvF1W4Q/artifacts/public/build/target.crashreporter-symbols.zip 12:13:36 INFO - Running post-action listener: _resource_record_post_action 12:13:36 INFO - [mozharness: 2017-04-09 19:13:36.070414Z] Finished read-buildbot-config step (success) 12:13:36 INFO - [mozharness: 2017-04-09 19:13:36.070633Z] Running download-and-extract step. 12:13:36 INFO - Running pre-action listener: _resource_record_pre_action 12:13:36 INFO - Running main action method: download_and_extract 12:13:36 INFO - mkdir: /builds/slave/test/build/tests 12:13:36 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')]} 12:13:36 INFO - trying https://queue.taskcluster.net/v1/task/EDYNlfHKRrKT8I4EvF1W4Q/artifacts/public/build/target.test_packages.json 12:13:36 INFO - Downloading https://queue.taskcluster.net/v1/task/EDYNlfHKRrKT8I4EvF1W4Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 12:13:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EDYNlfHKRrKT8I4EvF1W4Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 12:13:36 INFO - Downloaded 986 bytes. 12:13:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 12:13:36 INFO - Using the following test package requirements: 12:13:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 12:13:36 INFO - u'common': [u'target.common.tests.zip'], 12:13:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 12:13:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 12:13:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 12:13:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 12:13:36 INFO - u'mozbase': [u'target.common.tests.zip'], 12:13:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 12:13:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 12:13:36 INFO - u'web-platform': [u'target.common.tests.zip', 12:13:36 INFO - u'target.web-platform.tests.zip'], 12:13:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 12:13:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 12:13:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EDYNlfHKRrKT8I4EvF1W4Q/artifacts/public/build/target.common.tests.zip 12:13:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EDYNlfHKRrKT8I4EvF1W4Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:13:36 INFO - Fetch https://queue.taskcluster.net/v1/task/EDYNlfHKRrKT8I4EvF1W4Q/artifacts/public/build/target.common.tests.zip into memory 12:13:37 INFO - Expected file size: 58250672 12:13:37 INFO - Obtained file size: 58250672 12:13:47 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 12:13:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EDYNlfHKRrKT8I4EvF1W4Q/artifacts/public/build/target.common.tests.zip 12:13:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EDYNlfHKRrKT8I4EvF1W4Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 12:13:47 INFO - Fetch https://queue.taskcluster.net/v1/task/EDYNlfHKRrKT8I4EvF1W4Q/artifacts/public/build/target.common.tests.zip into memory 12:13:49 INFO - Expected file size: 58250672 12:13:49 INFO - Obtained file size: 58250672 12:14:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EDYNlfHKRrKT8I4EvF1W4Q/artifacts/public/build/target.talos.tests.zip 12:14:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EDYNlfHKRrKT8I4EvF1W4Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 12:14:01 INFO - Fetch https://queue.taskcluster.net/v1/task/EDYNlfHKRrKT8I4EvF1W4Q/artifacts/public/build/target.talos.tests.zip into memory 12:14:02 INFO - Expected file size: 14404129 12:14:02 INFO - Obtained file size: 14404129 12:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:02 INFO - trying https://queue.taskcluster.net/v1/task/EDYNlfHKRrKT8I4EvF1W4Q/artifacts/public/build/target.tar.bz2 12:14:02 INFO - Downloading https://queue.taskcluster.net/v1/task/EDYNlfHKRrKT8I4EvF1W4Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 12:14:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EDYNlfHKRrKT8I4EvF1W4Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 12:14:03 INFO - Downloaded 59040964 bytes. 12:14:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EDYNlfHKRrKT8I4EvF1W4Q/artifacts/public/build/target.tar.bz2 12:14:03 INFO - mkdir: /builds/slave/test/properties 12:14:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:14:03 INFO - Writing to file /builds/slave/test/properties/build_url 12:14:03 INFO - Contents: 12:14:03 INFO - build_url:https://queue.taskcluster.net/v1/task/EDYNlfHKRrKT8I4EvF1W4Q/artifacts/public/build/target.tar.bz2 12:14:03 INFO - Running post-action listener: _resource_record_post_action 12:14:03 INFO - Running post-action listener: set_extra_try_arguments 12:14:03 INFO - [mozharness: 2017-04-09 19:14:03.815500Z] Finished download-and-extract step (success) 12:14:03 INFO - [mozharness: 2017-04-09 19:14:03.815727Z] Running populate-webroot step. 12:14:03 INFO - Running pre-action listener: _resource_record_pre_action 12:14:03 INFO - Running main action method: populate_webroot 12:14:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:14:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:14:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:14:03 INFO - '--tppagecycles', 12:14:03 INFO - '7'], 12:14:03 INFO - 'tests': ['tsvgm']}}, 12:14:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:14:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:14:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:14:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:14:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:14:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:14:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:14:03 INFO - 'talos_options': ['--disable-e10s'], 12:14:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:14:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:14:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:14:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:14:03 INFO - 'talos_options': ['--disable-e10s'], 12:14:03 INFO - 'tests': ['damp', 'tps']}, 12:14:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:14:03 INFO - 'tests': ['damp', 'tps']}, 12:14:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:14:03 INFO - 'tests': ['dromaeo_dom']}, 12:14:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:14:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:14:03 INFO - 'tests': ['basic_compositor_video']}, 12:14:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:14:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:14:03 INFO - 'tests': ['a11yr', 12:14:03 INFO - 'ts_paint', 12:14:03 INFO - 'tpaint', 12:14:03 INFO - 'sessionrestore', 12:14:03 INFO - 'sessionrestore_no_auto_restore', 12:14:03 INFO - 'tabpaint']}, 12:14:03 INFO - 'other-e10s': {'tests': ['a11yr', 12:14:03 INFO - 'ts_paint', 12:14:03 INFO - 'tpaint', 12:14:03 INFO - 'sessionrestore', 12:14:03 INFO - 'sessionrestore_no_auto_restore', 12:14:03 INFO - 'tabpaint']}, 12:14:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:14:03 INFO - 'ts_paint', 12:14:03 INFO - 'tpaint', 12:14:03 INFO - 'sessionrestore', 12:14:03 INFO - 'sessionrestore_no_auto_restore', 12:14:03 INFO - 'tabpaint']}, 12:14:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:14:03 INFO - 'ts_paint', 12:14:03 INFO - 'tpaint', 12:14:03 INFO - 'sessionrestore', 12:14:03 INFO - 'sessionrestore_no_auto_restore', 12:14:03 INFO - 'tabpaint']}, 12:14:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:14:03 INFO - 'tests': ['a11yr', 12:14:03 INFO - 'ts_paint', 12:14:03 INFO - 'tpaint', 12:14:03 INFO - 'sessionrestore', 12:14:03 INFO - 'sessionrestore_no_auto_restore', 12:14:03 INFO - 'tabpaint']}, 12:14:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:14:03 INFO - 'tests': ['a11yr', 12:14:03 INFO - 'ts_paint', 12:14:03 INFO - 'tpaint', 12:14:03 INFO - 'sessionrestore', 12:14:03 INFO - 'sessionrestore_no_auto_restore', 12:14:03 INFO - 'tabpaint']}, 12:14:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:14:03 INFO - 'tests': ['tsvgx', 12:14:03 INFO - 'tsvgr_opacity', 12:14:03 INFO - 'tart', 12:14:03 INFO - 'tscrollx', 12:14:03 INFO - 'cart', 12:14:03 INFO - 'tsvg_static']}, 12:14:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:14:03 INFO - 'tsvgr_opacity', 12:14:03 INFO - 'tart', 12:14:03 INFO - 'tscrollx', 12:14:03 INFO - 'cart', 12:14:03 INFO - 'tsvg_static']}, 12:14:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:14:03 INFO - 'talos_options': ['--disable-e10s'], 12:14:03 INFO - 'tests': ['tp5o']}, 12:14:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:14:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:14:03 INFO - 'talos_options': ['--disable-e10s', 12:14:03 INFO - '--xperf_path', 12:14:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:14:03 INFO - 'tests': ['tp5n']}, 12:14:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:14:03 INFO - 'talos_options': ['--xperf_path', 12:14:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:14:03 INFO - 'tests': ['tp5n']}}, 12:14:03 INFO - 'talos.zip': {'path': '', 12:14:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:14:03 INFO - Running post-action listener: _resource_record_post_action 12:14:03 INFO - [mozharness: 2017-04-09 19:14:03.833583Z] Finished populate-webroot step (success) 12:14:03 INFO - [mozharness: 2017-04-09 19:14:03.833672Z] Running create-virtualenv step. 12:14:03 INFO - Running pre-action listener: _resource_record_pre_action 12:14:03 INFO - Running main action method: create_virtualenv 12:14:03 INFO - Creating virtualenv /builds/slave/test/build/venv 12:14:03 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 12:14:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:14:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:14:03 INFO - Using real prefix '/usr' 12:14:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:14:04 INFO - Installing distribute.............................................................................................................................................................................................done. 12:14:06 INFO - Installing pip.................done. 12:14:06 INFO - Return code: 0 12:14:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:14:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:14:06 INFO - Reading from file tmpfile_stdout 12:14:06 INFO - Output received: 12:14:06 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) 12:14:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:14: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')]} 12:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14: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')]} 12:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:06 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 0x14281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1465a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c6310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c3400>, '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 0x16c43b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c4840>, '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': '7de08804244eb36560b44971000001c3-1491764897.971542-71221440', '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 12:14:06 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 12:14:06 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 12:14:06 INFO - Using env: {'DISPLAY': ':0', 12:14:06 INFO - 'HOME': '/home/cltbld', 12:14:06 INFO - 'LANG': 'en_US.UTF-8', 12:14:06 INFO - 'LANGUAGE': 'en_US:en', 12:14:06 INFO - 'LOGNAME': 'cltbld', 12:14:06 INFO - 'MAIL': '/var/mail/cltbld', 12:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:06 INFO - 'MOZ_NO_REMOTE': '1', 12:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:06 INFO - 'NO_EM_RESTART': '1', 12:14:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:06 INFO - 'PWD': '/builds/slave/test', 12:14:06 INFO - 'SHELL': '/bin/bash', 12:14:06 INFO - 'SHLVL': '1', 12:14:06 INFO - 'TERM': 'linux', 12:14:06 INFO - 'TMOUT': '86400', 12:14:06 INFO - 'USER': 'cltbld', 12:14:06 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1491764897.971542-71221440', 12:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:06 INFO - '_': '/tools/buildbot/bin/python'} 12:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:06 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 12:14:06 INFO - Cleaning up... 12:14:06 INFO - Return code: 0 12:14:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:14: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')]} 12:14:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14: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')]} 12:14:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:06 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 0x14281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1465a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c6310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c3400>, '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 0x16c43b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c4840>, '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': '7de08804244eb36560b44971000001c3-1491764897.971542-71221440', '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 12:14:06 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 12:14:06 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 12:14:06 INFO - Using env: {'DISPLAY': ':0', 12:14:06 INFO - 'HOME': '/home/cltbld', 12:14:06 INFO - 'LANG': 'en_US.UTF-8', 12:14:06 INFO - 'LANGUAGE': 'en_US:en', 12:14:06 INFO - 'LOGNAME': 'cltbld', 12:14:06 INFO - 'MAIL': '/var/mail/cltbld', 12:14:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:06 INFO - 'MOZ_NO_REMOTE': '1', 12:14:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:06 INFO - 'NO_EM_RESTART': '1', 12:14:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:06 INFO - 'PWD': '/builds/slave/test', 12:14:06 INFO - 'SHELL': '/bin/bash', 12:14:06 INFO - 'SHLVL': '1', 12:14:06 INFO - 'TERM': 'linux', 12:14:06 INFO - 'TMOUT': '86400', 12:14:06 INFO - 'USER': 'cltbld', 12:14:06 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1491764897.971542-71221440', 12:14:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:06 INFO - '_': '/tools/buildbot/bin/python'} 12:14:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:07 INFO - Downloading/unpacking psutil>=3.1.1 12:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:14:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:14:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:14:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:14:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:14:09 INFO - Installing collected packages: psutil 12:14:09 INFO - Running setup.py install for psutil 12:14:09 INFO - building 'psutil._psutil_linux' extension 12:14:09 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 12:14:09 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 12:14:09 INFO - building 'psutil._psutil_posix' extension 12:14:09 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 12:14:09 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 12:14:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:14:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:14:09 INFO - Successfully installed psutil 12:14:09 INFO - Cleaning up... 12:14:09 INFO - Return code: 0 12:14:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:09 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 0x14281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1465a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c6310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c3400>, '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 0x16c43b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c4840>, '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': '7de08804244eb36560b44971000001c3-1491764897.971542-71221440', '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 12:14:09 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 12:14:09 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 12:14:09 INFO - Using env: {'DISPLAY': ':0', 12:14:09 INFO - 'HOME': '/home/cltbld', 12:14:09 INFO - 'LANG': 'en_US.UTF-8', 12:14:09 INFO - 'LANGUAGE': 'en_US:en', 12:14:09 INFO - 'LOGNAME': 'cltbld', 12:14:09 INFO - 'MAIL': '/var/mail/cltbld', 12:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:09 INFO - 'MOZ_NO_REMOTE': '1', 12:14:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:09 INFO - 'NO_EM_RESTART': '1', 12:14:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:09 INFO - 'PWD': '/builds/slave/test', 12:14:09 INFO - 'SHELL': '/bin/bash', 12:14:09 INFO - 'SHLVL': '1', 12:14:09 INFO - 'TERM': 'linux', 12:14:09 INFO - 'TMOUT': '86400', 12:14:09 INFO - 'USER': 'cltbld', 12:14:09 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1491764897.971542-71221440', 12:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:09 INFO - '_': '/tools/buildbot/bin/python'} 12:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:14:09 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 12:14:09 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 12:14:09 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 12:14:09 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 12:14:09 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 12:14:09 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 12:14:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:14:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:14:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:14:11 INFO - Installing collected packages: mozsystemmonitor 12:14:11 INFO - Running setup.py install for mozsystemmonitor 12:14:12 INFO - Successfully installed mozsystemmonitor 12:14:12 INFO - Cleaning up... 12:14:12 INFO - Return code: 0 12:14:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:14:12 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')]} 12:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:12 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')]} 12:14:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:12 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 0x14281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1465a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c6310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c3400>, '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 0x16c43b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c4840>, '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': '7de08804244eb36560b44971000001c3-1491764897.971542-71221440', '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 12:14:12 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 12:14:12 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 12:14:12 INFO - Using env: {'DISPLAY': ':0', 12:14:12 INFO - 'HOME': '/home/cltbld', 12:14:12 INFO - 'LANG': 'en_US.UTF-8', 12:14:12 INFO - 'LANGUAGE': 'en_US:en', 12:14:12 INFO - 'LOGNAME': 'cltbld', 12:14:12 INFO - 'MAIL': '/var/mail/cltbld', 12:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:12 INFO - 'MOZ_NO_REMOTE': '1', 12:14:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:12 INFO - 'NO_EM_RESTART': '1', 12:14:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:12 INFO - 'PWD': '/builds/slave/test', 12:14:12 INFO - 'SHELL': '/bin/bash', 12:14:12 INFO - 'SHLVL': '1', 12:14:12 INFO - 'TERM': 'linux', 12:14:12 INFO - 'TMOUT': '86400', 12:14:12 INFO - 'USER': 'cltbld', 12:14:12 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1491764897.971542-71221440', 12:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:12 INFO - '_': '/tools/buildbot/bin/python'} 12:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:12 INFO - Downloading/unpacking jsonschema==2.5.1 12:14:12 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 12:14:12 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 12:14:12 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 12:14:12 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 12:14:12 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 12:14:12 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 12:14:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:14:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:14:14 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 12:14:14 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 12:14:14 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 12:14:14 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 12:14:14 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 12:14:14 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 12:14:14 INFO - Downloading functools32-3.2.3-2.tar.gz 12:14:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:14:14 INFO - warning: no files found matching '*.txt' 12:14:14 INFO - no previously-included directories found matching 'build' 12:14:14 INFO - no previously-included directories found matching 'dist' 12:14:14 INFO - no previously-included directories found matching '.git*' 12:14:14 INFO - Installing collected packages: jsonschema, functools32 12:14:14 INFO - Running setup.py install for functools32 12:14:14 INFO - warning: no files found matching '*.txt' 12:14:14 INFO - no previously-included directories found matching 'build' 12:14:14 INFO - no previously-included directories found matching 'dist' 12:14:14 INFO - no previously-included directories found matching '.git*' 12:14:14 INFO - Successfully installed jsonschema functools32 12:14:14 INFO - Cleaning up... 12:14:14 INFO - Return code: 0 12:14:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:14:14 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')]} 12:14:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:14 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')]} 12:14:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:14 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 0x14281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1465a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c6310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c3400>, '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 0x16c43b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c4840>, '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': '7de08804244eb36560b44971000001c3-1491764897.971542-71221440', '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 12:14:14 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 12:14:14 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 12:14:14 INFO - Using env: {'DISPLAY': ':0', 12:14:14 INFO - 'HOME': '/home/cltbld', 12:14:14 INFO - 'LANG': 'en_US.UTF-8', 12:14:14 INFO - 'LANGUAGE': 'en_US:en', 12:14:14 INFO - 'LOGNAME': 'cltbld', 12:14:14 INFO - 'MAIL': '/var/mail/cltbld', 12:14:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:14 INFO - 'MOZ_NO_REMOTE': '1', 12:14:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:14 INFO - 'NO_EM_RESTART': '1', 12:14:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:14 INFO - 'PWD': '/builds/slave/test', 12:14:14 INFO - 'SHELL': '/bin/bash', 12:14:14 INFO - 'SHLVL': '1', 12:14:14 INFO - 'TERM': 'linux', 12:14:14 INFO - 'TMOUT': '86400', 12:14:14 INFO - 'USER': 'cltbld', 12:14:14 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1491764897.971542-71221440', 12:14:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:14 INFO - '_': '/tools/buildbot/bin/python'} 12:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:14:15 INFO - Cleaning up... 12:14:15 INFO - Return code: 0 12:14:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:14:15 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')]} 12:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:15 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')]} 12:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:15 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 0x14281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1465a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c6310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c3400>, '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 0x16c43b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c4840>, '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': '7de08804244eb36560b44971000001c3-1491764897.971542-71221440', '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 12:14:15 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 12:14:15 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 12:14:15 INFO - Using env: {'DISPLAY': ':0', 12:14:15 INFO - 'HOME': '/home/cltbld', 12:14:15 INFO - 'LANG': 'en_US.UTF-8', 12:14:15 INFO - 'LANGUAGE': 'en_US:en', 12:14:15 INFO - 'LOGNAME': 'cltbld', 12:14:15 INFO - 'MAIL': '/var/mail/cltbld', 12:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:15 INFO - 'MOZ_NO_REMOTE': '1', 12:14:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:15 INFO - 'NO_EM_RESTART': '1', 12:14:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:15 INFO - 'PWD': '/builds/slave/test', 12:14:15 INFO - 'SHELL': '/bin/bash', 12:14:15 INFO - 'SHLVL': '1', 12:14:15 INFO - 'TERM': 'linux', 12:14:15 INFO - 'TMOUT': '86400', 12:14:15 INFO - 'USER': 'cltbld', 12:14:15 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1491764897.971542-71221440', 12:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:15 INFO - '_': '/tools/buildbot/bin/python'} 12:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:15 INFO - Downloading/unpacking blobuploader==1.2.4 12:14:15 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 12:14:15 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 12:14:15 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 12:14:15 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 12:14:15 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 12:14:15 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 12:14:17 INFO - Downloading blobuploader-1.2.4.tar.gz 12:14:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:14:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:14:17 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 12:14:17 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 12:14:17 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 12:14:17 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 12:14:17 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 12:14:17 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 12:14:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:14:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:14:17 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 12:14:17 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 12:14:17 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 12:14:17 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 12:14:17 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 12:14:17 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 12:14:17 INFO - Downloading docopt-0.6.1.tar.gz 12:14:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:14:18 INFO - Installing collected packages: blobuploader, requests, docopt 12:14:18 INFO - Running setup.py install for blobuploader 12:14:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:14:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:14:18 INFO - Running setup.py install for requests 12:14:18 INFO - Running setup.py install for docopt 12:14:18 INFO - Successfully installed blobuploader requests docopt 12:14:18 INFO - Cleaning up... 12:14:18 INFO - Return code: 0 12:14:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:18 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 0x14281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1465a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c6310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c3400>, '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 0x16c43b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c4840>, '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': '7de08804244eb36560b44971000001c3-1491764897.971542-71221440', '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 12:14:18 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 12:14:18 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 12:14:18 INFO - Using env: {'DISPLAY': ':0', 12:14:18 INFO - 'HOME': '/home/cltbld', 12:14:18 INFO - 'LANG': 'en_US.UTF-8', 12:14:18 INFO - 'LANGUAGE': 'en_US:en', 12:14:18 INFO - 'LOGNAME': 'cltbld', 12:14:18 INFO - 'MAIL': '/var/mail/cltbld', 12:14:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:18 INFO - 'MOZ_NO_REMOTE': '1', 12:14:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:18 INFO - 'NO_EM_RESTART': '1', 12:14:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:18 INFO - 'PWD': '/builds/slave/test', 12:14:18 INFO - 'SHELL': '/bin/bash', 12:14:18 INFO - 'SHLVL': '1', 12:14:18 INFO - 'TERM': 'linux', 12:14:18 INFO - 'TMOUT': '86400', 12:14:18 INFO - 'USER': 'cltbld', 12:14:18 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1491764897.971542-71221440', 12:14:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:18 INFO - '_': '/tools/buildbot/bin/python'} 12:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:14:18 INFO - Running setup.py (path:/tmp/pip-iv0wlN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:14:18 INFO - Running setup.py (path:/tmp/pip-uXOHvO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:14:19 INFO - Running setup.py (path:/tmp/pip-ouaqrZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:14:19 INFO - Running setup.py (path:/tmp/pip-5MJ9Kh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:14:19 INFO - Running setup.py (path:/tmp/pip-60yvTv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:14:19 INFO - Running setup.py (path:/tmp/pip-d_ce2C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:14:19 INFO - Running setup.py (path:/tmp/pip-VU3Brq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:14:19 INFO - Running setup.py (path:/tmp/pip-8SgF0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:14:19 INFO - Running setup.py (path:/tmp/pip-Felb5u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:14:19 INFO - Running setup.py (path:/tmp/pip-xuTqOe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:14:19 INFO - Running setup.py (path:/tmp/pip-VNpfLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:14:19 INFO - Running setup.py (path:/tmp/pip-6OcoKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:14:19 INFO - Running setup.py (path:/tmp/pip-HtMyLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:14:19 INFO - Running setup.py (path:/tmp/pip-66l1Dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:19 INFO - Running setup.py (path:/tmp/pip-urCZKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:14:19 INFO - Running setup.py (path:/tmp/pip-yiZol6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:14:20 INFO - Running setup.py (path:/tmp/pip-Cr11vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:14:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:14:20 INFO - Running setup.py install for manifestparser 12:14:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:14:20 INFO - Running setup.py install for mozcrash 12:14:20 INFO - Running setup.py install for mozdebug 12:14:20 INFO - Running setup.py install for mozdevice 12:14:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:14:20 INFO - Running setup.py install for mozfile 12:14:20 INFO - Running setup.py install for mozhttpd 12:14:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:14:20 INFO - Running setup.py install for mozinfo 12:14:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:14:20 INFO - Running setup.py install for mozInstall 12:14:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:14:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:14:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:14:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:14:20 INFO - Running setup.py install for mozleak 12:14:21 INFO - Running setup.py install for mozlog 12:14:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:14:21 INFO - Running setup.py install for moznetwork 12:14:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:14:21 INFO - Running setup.py install for mozprocess 12:14:21 INFO - Running setup.py install for mozprofile 12:14:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:14:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:14:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:14:21 INFO - Running setup.py install for mozrunner 12:14:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:14:21 INFO - Running setup.py install for mozscreenshot 12:14:21 INFO - Running setup.py install for moztest 12:14:21 INFO - Running setup.py install for mozversion 12:14:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:14:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:14:21 INFO - Cleaning up... 12:14:21 INFO - Return code: 0 12:14:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14:21 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')]} 12:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:21 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')]} 12:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:21 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 0x14281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1465a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c6310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c3400>, '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 0x16c43b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c4840>, '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': '7de08804244eb36560b44971000001c3-1491764897.971542-71221440', '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 12:14:21 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 12:14:21 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 12:14:21 INFO - Using env: {'DISPLAY': ':0', 12:14:21 INFO - 'HOME': '/home/cltbld', 12:14:21 INFO - 'LANG': 'en_US.UTF-8', 12:14:21 INFO - 'LANGUAGE': 'en_US:en', 12:14:21 INFO - 'LOGNAME': 'cltbld', 12:14:21 INFO - 'MAIL': '/var/mail/cltbld', 12:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:21 INFO - 'MOZ_NO_REMOTE': '1', 12:14:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:21 INFO - 'NO_EM_RESTART': '1', 12:14:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:21 INFO - 'PWD': '/builds/slave/test', 12:14:21 INFO - 'SHELL': '/bin/bash', 12:14:21 INFO - 'SHLVL': '1', 12:14:21 INFO - 'TERM': 'linux', 12:14:21 INFO - 'TMOUT': '86400', 12:14:21 INFO - 'USER': 'cltbld', 12:14:21 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1491764897.971542-71221440', 12:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:21 INFO - '_': '/tools/buildbot/bin/python'} 12:14:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:14:22 INFO - Running setup.py (path:/tmp/pip-0Ah5Mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:14:22 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)) 12:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:14:22 INFO - Running setup.py (path:/tmp/pip-3la92S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:14:22 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)) 12:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:14:22 INFO - Running setup.py (path:/tmp/pip-LvfcXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:14:22 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)) 12:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:14:22 INFO - Running setup.py (path:/tmp/pip-0A6LoT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:14:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 12:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:14:22 INFO - Running setup.py (path:/tmp/pip-IpwAc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:14:22 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)) 12:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:14:22 INFO - Running setup.py (path:/tmp/pip-IGrMkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:14:22 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)) 12:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:14:22 INFO - Running setup.py (path:/tmp/pip-UJUnet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:14:22 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)) 12:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:14:22 INFO - Running setup.py (path:/tmp/pip-_0rZS4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:14:22 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)) 12:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:14:22 INFO - Running setup.py (path:/tmp/pip-E9_lTO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:14:22 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)) 12:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:14:22 INFO - Running setup.py (path:/tmp/pip-P0PTnW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:14:22 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)) 12:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:14:22 INFO - Running setup.py (path:/tmp/pip-rI9P9y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:14:22 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)) 12:14:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:14:22 INFO - Running setup.py (path:/tmp/pip-ePOTdj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:14:23 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)) 12:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:14:23 INFO - Running setup.py (path:/tmp/pip-Cmyugp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:14:23 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)) 12:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:14:23 INFO - Running setup.py (path:/tmp/pip-XcWcrr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:14:23 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)) 12:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:23 INFO - Running setup.py (path:/tmp/pip-U3Y_a1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:14:23 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)) 12:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:14:23 INFO - Running setup.py (path:/tmp/pip-LTrtXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:14:23 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)) 12:14:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:14:23 INFO - Running setup.py (path:/tmp/pip-l13HLE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:14:23 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)) 12:14:23 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)) 12:14:23 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)) 12:14:23 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)) 12:14:23 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:14:23 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:14:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:14:23 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 12:14:23 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 12:14:23 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 12:14:23 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 12:14:23 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 12:14:23 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 12:14:26 INFO - Downloading blessings-1.6.tar.gz 12:14:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:14:26 INFO - Installing collected packages: blessings 12:14:26 INFO - Running setup.py install for blessings 12:14:26 INFO - Successfully installed blessings 12:14:26 INFO - Cleaning up... 12:14:26 INFO - Return code: 0 12:14:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:14:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:14:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:14:26 INFO - Reading from file tmpfile_stdout 12:14:26 INFO - Current package versions: 12:14:26 INFO - argparse == 1.2.1 12:14:26 INFO - blessings == 1.6 12:14:26 INFO - blobuploader == 1.2.4 12:14:26 INFO - docopt == 0.6.1 12:14:26 INFO - functools32 == 3.2.3-2 12:14:26 INFO - jsonschema == 2.5.1 12:14:26 INFO - manifestparser == 1.1 12:14:26 INFO - mozInstall == 1.12 12:14:26 INFO - mozcrash == 1.0 12:14:26 INFO - mozdebug == 0.1 12:14:26 INFO - mozdevice == 0.50 12:14:26 INFO - mozfile == 1.2 12:14:26 INFO - mozhttpd == 0.7 12:14:26 INFO - mozinfo == 0.9 12:14:26 INFO - mozleak == 0.1 12:14:26 INFO - mozlog == 3.4 12:14:26 INFO - moznetwork == 0.27 12:14:26 INFO - mozprocess == 0.25 12:14:26 INFO - mozprofile == 0.28 12:14:26 INFO - mozrunner == 6.13 12:14:26 INFO - mozscreenshot == 0.1 12:14:26 INFO - mozsystemmonitor == 0.3 12:14:26 INFO - moztest == 0.8 12:14:26 INFO - mozversion == 1.4 12:14:26 INFO - psutil == 3.1.1 12:14:26 INFO - requests == 1.2.3 12:14:26 INFO - wsgiref == 0.1.2 12:14:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:26 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 0x14281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1465a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c6310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c3400>, '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 0x16c43b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c4840>, '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': '7de08804244eb36560b44971000001c3-1491764897.971542-71221440', '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 12:14:26 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 12:14:26 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 12:14:26 INFO - Using env: {'DISPLAY': ':0', 12:14:26 INFO - 'HOME': '/home/cltbld', 12:14:26 INFO - 'LANG': 'en_US.UTF-8', 12:14:26 INFO - 'LANGUAGE': 'en_US:en', 12:14:26 INFO - 'LOGNAME': 'cltbld', 12:14:26 INFO - 'MAIL': '/var/mail/cltbld', 12:14:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:26 INFO - 'MOZ_NO_REMOTE': '1', 12:14:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:26 INFO - 'NO_EM_RESTART': '1', 12:14:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:26 INFO - 'PWD': '/builds/slave/test', 12:14:26 INFO - 'SHELL': '/bin/bash', 12:14:26 INFO - 'SHLVL': '1', 12:14:26 INFO - 'TERM': 'linux', 12:14:26 INFO - 'TMOUT': '86400', 12:14:26 INFO - 'USER': 'cltbld', 12:14:26 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1491764897.971542-71221440', 12:14:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:26 INFO - '_': '/tools/buildbot/bin/python'} 12:14:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:27 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)) 12:14:27 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)) 12:14:27 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)) 12:14:27 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)) 12:14:27 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)) 12:14:27 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)) 12:14:27 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)) 12:14:27 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)) 12:14:27 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)) 12:14:27 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)) 12:14:27 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)) 12:14:27 INFO - Cleaning up... 12:14:27 INFO - Return code: 0 12:14:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:14:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:14:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:14:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:14:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:14:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14281f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1465a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16c6310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16c3400>, '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 0x16c43b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c4840>, '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': '7de08804244eb36560b44971000001c3-1491764897.971542-71221440', '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 12:14:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 12:14:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 12:14:27 INFO - Using env: {'DISPLAY': ':0', 12:14:27 INFO - 'HOME': '/home/cltbld', 12:14:27 INFO - 'LANG': 'en_US.UTF-8', 12:14:27 INFO - 'LANGUAGE': 'en_US:en', 12:14:27 INFO - 'LOGNAME': 'cltbld', 12:14:27 INFO - 'MAIL': '/var/mail/cltbld', 12:14:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:27 INFO - 'MOZ_NO_REMOTE': '1', 12:14:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:27 INFO - 'NO_EM_RESTART': '1', 12:14:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:27 INFO - 'PWD': '/builds/slave/test', 12:14:27 INFO - 'SHELL': '/bin/bash', 12:14:27 INFO - 'SHLVL': '1', 12:14:27 INFO - 'TERM': 'linux', 12:14:27 INFO - 'TMOUT': '86400', 12:14:27 INFO - 'USER': 'cltbld', 12:14:27 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1491764897.971542-71221440', 12:14:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:27 INFO - '_': '/tools/buildbot/bin/python'} 12:14:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:14:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:14:27 INFO - Cleaning up... 12:14:27 INFO - Return code: 0 12:14:27 INFO - Running post-action listener: _resource_record_post_action 12:14:27 INFO - Running post-action listener: _start_resource_monitoring 12:14:27 INFO - Starting resource monitoring. 12:14:27 INFO - [mozharness: 2017-04-09 19:14:27.335491Z] Finished create-virtualenv step (success) 12:14:27 INFO - [mozharness: 2017-04-09 19:14:27.336011Z] Running install step. 12:14:27 INFO - Running pre-action listener: _resource_record_pre_action 12:14:27 INFO - Running main action method: install 12:14:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:14:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:14:27 INFO - Reading from file tmpfile_stdout 12:14:27 INFO - Detecting whether we're running mozinstall >=1.0... 12:14:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:14:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:14:27 INFO - Reading from file tmpfile_stdout 12:14:27 INFO - Output received: 12:14:27 INFO - Usage: mozinstall [options] installer 12:14:27 INFO - Options: 12:14:27 INFO - -h, --help show this help message and exit 12:14:27 INFO - -d DEST, --destination=DEST 12:14:27 INFO - Directory to install application into. [default: 12:14:27 INFO - "/builds/slave/test"] 12:14:27 INFO - --app=APP Application being installed. [default: firefox] 12:14:27 INFO - mkdir: /builds/slave/test/build/application 12:14:27 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'] 12:14:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 12:14:42 INFO - Reading from file tmpfile_stdout 12:14:42 INFO - Output received: 12:14:42 INFO - /builds/slave/test/build/application/firefox/firefox 12:14:42 INFO - Running post-action listener: _resource_record_post_action 12:14:42 INFO - [mozharness: 2017-04-09 19:14:42.718286Z] Finished install step (success) 12:14:42 INFO - [mozharness: 2017-04-09 19:14:42.718431Z] Running run-tests step. 12:14:42 INFO - Running pre-action listener: _resource_record_pre_action 12:14:42 INFO - Running main action method: run_tests 12:14:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:14:42 INFO - Python 2.7.3 12:14:42 INFO - Return code: 0 12:14:42 INFO - grabbing minidump binary from tooltool 12:14:42 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')]} 12:14:42 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 0x16c3400>, '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 0x16c43b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x16c4840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:14:42 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 12:14:42 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 12:14:42 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 12:14:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:14:42 INFO - Return code: 0 12:14:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:14:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:14:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:14:42 INFO - ENV: RUST_BACKTRACE is now 1 12:14:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:14:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:14:42 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/EDYNlfHKRrKT8I4EvF1W4Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 12:14:42 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/EDYNlfHKRrKT8I4EvF1W4Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-003 --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 12:14:42 INFO - Using env: {'DISPLAY': ':0', 12:14:42 INFO - 'HOME': '/home/cltbld', 12:14:42 INFO - 'LANG': 'en_US.UTF-8', 12:14:42 INFO - 'LANGUAGE': 'en_US:en', 12:14:42 INFO - 'LOGNAME': 'cltbld', 12:14:42 INFO - 'MAIL': '/var/mail/cltbld', 12:14:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:14:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:14:42 INFO - 'MOZ_NO_REMOTE': '1', 12:14:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:14:42 INFO - 'NO_EM_RESTART': '1', 12:14:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:14:42 INFO - 'PWD': '/builds/slave/test', 12:14:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:14:42 INFO - 'RUST_BACKTRACE': '1', 12:14:42 INFO - 'SHELL': '/bin/bash', 12:14:42 INFO - 'SHLVL': '1', 12:14:42 INFO - 'TERM': 'linux', 12:14:42 INFO - 'TMOUT': '86400', 12:14:42 INFO - 'USER': 'cltbld', 12:14:42 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1491764897.971542-71221440', 12:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:14:42 INFO - '_': '/tools/buildbot/bin/python'} 12:14:42 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/EDYNlfHKRrKT8I4EvF1W4Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--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 12:14:43 INFO - mozversion application_buildid: 20170409183435 12:14:43 INFO - mozversion application_changeset: 45692c884fdd5136a64fb2f8a61a0c8183b69331 12:14:43 INFO - mozversion application_display_name: Nightly 12:14:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:14:43 INFO - mozversion application_name: Firefox 12:14:43 INFO - mozversion application_remotingname: firefox 12:14:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:14:43 INFO - mozversion application_vendor: Mozilla 12:14:43 INFO - mozversion application_version: 55.0a1 12:14:43 INFO - mozversion platform_buildid: 20170409183435 12:14:43 INFO - mozversion platform_changeset: 45692c884fdd5136a64fb2f8a61a0c8183b69331 12:14:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:14:43 INFO - mozversion platform_version: 55.0a1 12:14:43 INFO - using testdate: 1491765283 12:14:43 INFO - actual date: 1491765283 12:14:43 INFO - starting webserver on 'localhost:57342' 12:14:43 INFO - SUITE-START | Running 2 tests 12:14:43 INFO - TEST-START | dromaeo_css 12:14:43 INFO - operating with platform_type : linux_ 12:14:43 INFO - Initialising browser for dromaeo_css test... 12:14:43 INFO - TEST-INFO | started process 2987 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3G1oRr/profile http://localhost:57342/getInfo.html) 12:14:47 INFO - PID 2987 | __metrics Screen width/height:1600/1200 12:14:47 INFO - PID 2987 | colorDepth:24 12:14:47 INFO - PID 2987 | Browser inner width/height: 1024/697 12:14:47 INFO - PID 2987 | __metrics 12:14:49 INFO - PID 2987 | 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" 12:14:49 INFO - PID 2987 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:14:50 INFO - TEST-INFO | 2987: exit 0 12:14:50 INFO - Browser initialized. 12:14:50 INFO - Running cycle 1/1 for dromaeo_css test... 12:14:50 INFO - TEST-INFO | started process 3088 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3G1oRr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:15:02 INFO - PID 3088 | RSS: Main: 170762240 12:15:02 INFO - PID 3088 | 12:18:09 INFO - PID 3088 | Cycle 1(1): loaded http://localhost:57342/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57342/tests/dromaeo/cssquery-ext.html) 12:18:11 INFO - PID 3088 | RSS: Main: 312893440 12:18:11 INFO - PID 3088 | 12:19:52 INFO - PID 3088 | ************************* 12:19:52 INFO - PID 3088 | A coding exception was thrown and uncaught in a Task. 12:19:52 INFO - PID 3088 | 12:19:52 ERROR - PID 3088 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:19:52 INFO - PID 3088 | Full stack: 12:19:52 INFO - PID 3088 | ************************* 12:19:52 INFO - PID 3088 | ************************* 12:19:52 INFO - PID 3088 | A coding exception was thrown and uncaught in a Task. 12:19:52 INFO - PID 3088 | 12:19:52 ERROR - PID 3088 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:19:52 INFO - PID 3088 | Full stack: 12:19:52 INFO - PID 3088 | ************************* 12:19:52 INFO - PID 3088 | ************************* 12:19:52 INFO - PID 3088 | A coding exception was thrown and uncaught in a Task. 12:19:52 INFO - PID 3088 | 12:19:52 ERROR - PID 3088 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:19:52 INFO - PID 3088 | Full stack: 12:19:52 INFO - PID 3088 | ************************* 12:19:52 INFO - PID 3088 | ************************* 12:19:52 INFO - PID 3088 | A coding exception was thrown and uncaught in a Task. 12:19:52 INFO - PID 3088 | 12:19:52 ERROR - PID 3088 | Full message: TypeError: NetworkError when attempting to fetch resource. 12:19:52 INFO - PID 3088 | Full stack: 12:19:52 INFO - PID 3088 | ************************* 12:21:13 INFO - PID 3088 | Cycle 1(1): loaded http://localhost:57342/tests/dromaeo/cssquery-ext.html (next: http://localhost:57342/tests/dromaeo/cssquery-jquery.html) 12:21:14 INFO - PID 3088 | RSS: Main: 260251648 12:21:14 INFO - PID 3088 | 12:24:16 INFO - PID 3088 | Cycle 1(1): loaded http://localhost:57342/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57342/tests/dromaeo/cssquery-mootools.html) 12:24:17 INFO - PID 3088 | RSS: Main: 203431936 12:24:17 INFO - PID 3088 | 12:27:19 INFO - PID 3088 | Cycle 1(1): loaded http://localhost:57342/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57342/tests/dromaeo/cssquery-prototype.html) 12:27:20 INFO - PID 3088 | RSS: Main: 236642304 12:27:20 INFO - PID 3088 | 12:30:23 INFO - PID 3088 | Cycle 1(1): loaded http://localhost:57342/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57342/tests/dromaeo/cssquery-yui.html) 12:30:24 INFO - PID 3088 | RSS: Main: 214368256 12:30:24 INFO - PID 3088 | 12:33:26 INFO - PID 3088 | Cycle 1(1): loaded http://localhost:57342/tests/dromaeo/cssquery-yui.html (next: http://localhost:57342/tests/dromaeo/cssquery-dojo.html) 12:33:26 INFO - PID 3088 | RSS: Main: 296394752 12:33:26 INFO - PID 3088 | 12:33:26 INFO - PID 3088 | __start_tp_report 12:33:26 INFO - PID 3088 | _x_x_mozilla_page_load 12:33:26 INFO - PID 3088 | _x_x_mozilla_page_load_details 12:33:26 INFO - PID 3088 | |i|pagename|runs| 12:33:26 INFO - PID 3088 | |0;dojo.html;2764.447110577885;2789.065663002894;2826.7173282671724;2827.660680718313;2838.091810620602;5242.082635538784;5375.086235339992;5383.515483606475;5420.457954204582;5458.617896747224;5357.11607584749;5361.463853614647;5393.029254734146;5454.809081682142;5483.314585676791;4783.210770222909;4797.472278049412;4798.136335459616;4800.279958006292;4849.127157111719;4771.475137734847;4818.734969576672;4848.660593758438;4852.563269305761;4895.241237608177;4695.5539223773685;4742.5020372861045;4766.046790641885;4785.49752276013;4843.104025755229;4721.26820342844;4724.598409135193;4743.146233677971;4788.353572267734;4804.903901921942;4699.177643912336;4703.976480117578;4711.528847115261;4716.245400735866;4752.42970843501;5147.510986456281;5208.583313334924;5211.687298762086;5234.398044224887;5276.7889284428575;5657.066584013633;5750;5764.07774756037;5793.710314484259;5890.204822349014;5894.852628684317;5898.941010589882;5910.468057874769;5913.497352725023;5963.314218864799;5442.156465747816;5457.317835270591;5462.562994960394;5462.945370546323;5467.398586155519;5845.766169353178;5878.970605147032;5933.881322373615;6008.519318454513;6024.789132380346;5724.427557244242;5762;5767.480926716616;5789.421057894177;5792.681402522818;5782.797602083907;5836.270466191726;5842.5618078644275;5845.532357411397;5846.619969701956;5733.197352370671;5767.711614419262;5776.855578610568;5785.1611516329895;5787.942120578825;5601.60788744784;5685.459881311269;5691.089425691952;5695.515881150066;5705.115707065412;4939.061578300111;4955.281484184845;4957.983613359253;4959.057779021974;4963.354763880672;4136.131412403429;4201.306784380604;4220;4252.574742525722;4261.573842615776;4966.90066198674;4968.205087186033;4968.6025117990475;4999.3000979862845;5004.199328107486;5827.242458480455;5839.532837373;5839.766409343579;5841.649501029951;5846;4775.21209000518;4828.082664293773;4960.255961605716;4960.404751429852;5001.474845141208;5194.298769666122;5203.7918483261;5218.060749065129;5223.4776522347465;5277.261183434322;5464.562834973272;5480.835574932758;5521.585881058856;5527.39198688152;5532.944670553243;5841.474267315962;5853.678047707417;5854.765809367577;5855.531557475477;5858.853528661817;5382.569394448513;5439.5920305978;5451.236826844166;5462.016836969384;5466.535344495763;5701.344345400166;5726.484616384545;5767.336756273083;5772.682502462405;5807.709614519342;5809.2738407699035;5824.5631577631;5827.184194212899;5829.504492118048;5833.970830145822;5453.481919217668;5563.443655634404;5612.074007788832;5618.213450116905;5623.831285061455;5523.917141242804;5579.4420557945505;5589.389835749962;5698.116791897262;5705.087186050212;5541.445855414427;5542.473465020817;5545.334559852843;5589.972050139723;5592;5648.068068768772;5691.971540142438;5696.515796157208;5698.743556539883;5713.628614140068;5367.624266301322;5411.540019098421;5418.512333889968;5421.9186712200135;5557.610967232255 12:33:26 INFO - PID 3088 | |1;ext.html;655.9803205903821;703.1527009953006;723.6851969393316;1059.713877253142;1072.0405237312605;26574.20277391679;33601.49597756033;34290.828545857265;34383.65616343836;34395.484067738944;35626.109347266334;35939;35961;35979.640203597955;36112.2777544449;7161.427085833121;7308.817279568;7309.524880882752;7309.67106480207;7310.853782924339;5537.224788529609;5655.0386434306065;6996.3003699630135;7023.648817559101;7049.718011279542;7198.712051517933;7256.927430725678;7259.41924646027;7259.927400725978;7270.236625154362;7117.288271172842;7163.31948464895;7194.424446044304;7206.711731530732;7215.639218039129;7215.278472152795;7263.418926485869;7264.38252748517;7264.891026634605;7265.055542779458;31733;31864;31885.202869928205;31899.52150717741;31915.202119946956;3031.4846476098896;3040.9847950760327;3058.541218817173;3061.9846900765356;3062.8009179403266;24288;24443.511129777304;24467.388315292083;24492.265232043068;24500.877495612585;3052.0700127877262;3086.4752991991413;3089.2894634234026;3095.2107212660853;3119.111053349807;138343.30828345794;138450.30774846062;139222;139316.99999999898;139849;41352.55266065673;41494.1701165981;41518.58481415147;41550.37674434886;41596;43621.345679814825;43637.78181109138;43684.56315436868;43715;43781.12437751291;12547.498100076078;12635.684107897192;12651.430685619169;12656.620301390973;12661.683457913441;8666.913330866611;10212.591496340212;10220.744481387876;10226.488675566192;10266.58933642646;10226.693199204035;11463.713407164887;11471.827922581168;11715.648530544097;11731.296122232694;4888.26675998596;4891.633127515451;4902.583280421204;4904.2643603459765;4921.532454416824;897.82043591282;908.8727578139066;926.2358554192817;947.4220725357526;948.6442584030989;20731.27440539574;20786.168553258;21257.149714011575;21272.574548509252;21514.78485215159;976.3751199232497;983.4590974963742;985.0838719990478;1003.6386900715737;1012.9240306977006;10732.624358147428;11288.830667539993;11296.152788540729;11308.208425410143;11481.88518114825;183226;183286;183972;184365;184891;39564.80217598894;39623.839496852415;39776.20447591032;39838;39865;1212.7089498520293;1255.0022731928138;1261.066810560179;1265.5950095969201;1268.9048321375749;19518.414447566596;19721;19920.800791991893;20461.693074603594;20961.790382096595;27988.16035518938;28158.2960425991;28169.859150704116;28185.295367615152;28194;179638;179644;179733;179859;180621;27443.31391715223;28017;28117;28201.717982819908;28254.717452825207;29525.114246572637;30182;33384.666153338156;34044.829775850965;34539.30921381609;26244.606330905433;26321;26499.60250596204;26795.598066029415;26916.192514224604;25602.35994100088;25970.35074123162;26153.60769588496;26771.33071673146;27255;29164.27089322784;29274.560881586367;33781;34643.13392165216;34994.300113998084;35249.126420347784;36237.0940726484;36259.45610815893;36603.26793464169;36613.450798238584;26608.20175394741;27162.320941975817;28027.66444422347;28066.438671226868;28464 12:33:26 INFO - PID 3088 | |2;jquery.html;427.6300999635316;428.5414606371183;429.4742608933848;441.79898146343413;446.1367254362808;16916.069616171106;17506.29974801008;18067.81932180678;18182.636347273048;18335.358262460817;17562.82437175628;17903.373381931637;18625.813741862577;18674.719879201824;18769.155388007537;5654.971725141369;5669.036263835148;5773.249477567911;5816.185733997244;5817;5641.717914104299;5758;5771.018926782436;5775.2203452534;5776.39347868474;5528.5024347808685;5662;5683.801066962657;5700.543956483492;5705.62913410627;5628;5642.125470552071;5661.1508273758855;5681;5687.658740475585;5049.798008079672;5175.327207463006;5178.715170665612;5212.582993360522;5218.086834803894;21520.784792152033;21609.783902160936;21721.34835954924;21795.23716669909;21879.67180492278;1539.5612250508552;1573.6301969037268;1585.2786981923198;1586.2623879895905;1586.2861712229542;14130.22283774392;14216.573502794932;14297.642558936006;14443.422263109464;14518.128912265192;2051.2820512820545;2090.4773806548365;2132.616129096762;2137.444264491228;2183.923562675299;66730.66634666844;80684.59657701732;88688.5565572168;88909.55545222296;91592.54203729006;10948.288361256493;11218.719532011602;11285.614315705256;11439.59961401347;11586.652400428;16014.439494617633;16014.919925400298;16036.198190090448;16042.75935860963;16051.277692503865;7554.2823431773895;7727.459077864608;7844.960775196201;7921;7936.444448888637;7017.193022802443;7043.401310888529;7116.750913717995;7247.20280769115;7285.307895749896;7079.115110611174;7080.327368899946;7152.249013853574;7231.132264128339;7272.96363518179;2015.9496012599802;2057.6913462980374;2071.1197740960033;2084.0725876984598;2117.9576408472053;859.4155973937783;865.8181781825762;894.2935081285841;900.7708807150366;917.9541022948825;17623.647527049387;18110.366137185134;18182.272709091754;18259.817401826076;18557.25770969146;884.1688812516214;886.5079880666163;889.1242126505387;902.7521471535829;913.4382354851718;9637.614495420245;11266.7183320416;12338.259704417584;12348.88860002604;12399.938000309941;472794;481738;487356;491932;496402;87764;92621.53689231511;93332;95681.5215923916;96221;1098.6594155811724;1116.966491005255;1161.372858656316;1162.4536467860091;1162.5175552145934;17462.206047032414;17671.293148273926;18204.908975455037;19749.1112899917;19781.70327445118;43943.78028109839;45698.543014569426;45967.72580935464;46993.24054075734;47721.76139119282;53839;55197.72401137969;55781;56426.153607695094;57185.71407142938;7822.765317040498;7896;7954.5624990623755;7962.880556791537;8108.432409731262;11553.364564949008;11692.590759323382;11766.294022358687;12142.271463712206;12216.205946613798;10407.58369665205;10407.895921040692;10523.894761052597;10601.787964240517;10920.235583509078;9773.41359518431;10168.847467288144;10284;10336.483175841027;10342.069213770495;9481.905180948102;9513.904860951301;9875.456849873326;10036.799264014824;10117.392956422638;8039.638216280398;8044.678212871654;8200.26197642215;8361.540115293717;8454.873176902229;10411;10475.58097676115;10561.049505544537;10667.093297069525;10870.34777913296 12:33:26 INFO - PID 3088 | |3;mootools.html;1296.805479178123;1368.9041767076303;1372.053283234568;1385.7436374270767;1392.97910531342;9368.531573421327;9690.079442452974;9695.515224238796;9723.416595004286;9742.610295588176;10082.243831712633;10471.73820654484;10476.790464190712;10480.318779279341;10496.632617858377;2298.2071185441037;2343.9414014649683;2346.7301260355107;2348.765123487646;2352.8235382346306;2203.162798136706;2309.607366747657;2353.1646265575732;2353.2234362660365;2355.7290911545133;2282.2126366403645;2322.918697845576;2337.2520793346134;2356.2577787996725;2367.7987371073477;2122.3420739570784;2235.228846048111;2254.132159118743;2254.785795349439;2258.559580881737;1882.6517094337455;1952.0337432970628;2213.2806837777625;2214.970038931888;2222;10023.49882505879;10384.221183411275;10392.220583456272;10392.53233604482;10399.428031458267;5690.378242200953;5891.440313170242;5914.083317085859;5914.4676979071655;5917.792877249319;2994.610700608907;3131.968680313213;3510.8771193008124;3589.10272431892;3595.7123430125525;1132;1135.9545618175264;1145.5909231645123;1152.5793085523808;1161.96514104577;14416.351264193136;14615.78076328856;14638.853611463855;14653.487127950577;14691.63270918225;4915.48387419323;5050.292958985671;5138.254953031864;5147.1507201312115;5175.663581867167;11468.598599048993;11482.712932176595;11485.942570287096;11492.597759078391;11503.942480287713;5830.970845145832;5839.766409343663;5844.152597873284;5848.678322692293;5850.385709500441;5244.5527351161445;5400.756965936543;5401.243825864382;5481.561475081984;5492.313460817398;3876.5154355705536;4011.618896204856;4020.43713880057;4077.918441631151;4085.2442298174337;1210.509743553862;1226.589092653971;1228.2078059651474;1235.4440501774238;1235.567551357018;697.5988806436319;708.4155571653406;718.867009603225;719.9784006479814;736.3078706016328;5310.176922577007;5375.354957405137;5420.512153906088;5495.6153069284765;5516.91724624131;535.3843080457505;542.2435702195415;554.0691638048118;554.4677109974389;558.5782734035777;3288.5067239914206;3608.224231790178;3629.4192929131214;3636.3272794533095;3731.197792474631;12678.591067697109;13189.604311870658;13265;13327.466901324033;13899.86100139006;13514.32428378577;13547.119437236548;13665.316734163252;13674.93162534181;13826.516071937434;9723.805523889483;9800.852987205197;9906.405615663083;9923.751906202402;9962.203023758082;5883.94116058834;5948.464638182411;6013;6017.097435384552;6060.696950155561;11966.760664786829;12141.817872731739;12206.633800985985;12316.876831231573;12375.566855160027;12539.184952978027;12539.651808717983;12721.427535760728;12873.935630321788;12875.034372421918;7711.807204819925;7886.132525422085;7893.447458678067;7896.447248692536;7897.052353717361;9725.756856078655;9744.561494732896;9819.509024548886;9830.361026533252;9847.409155450408;8270.875936861072;8280.296174824967;8379.916200837913;8398.832023359377;8487.745367638981;8271.296939760188;8281.95859020701;8297;8366.079731229682;8379.664813407395;6574.934250657432;6667.133272674521;6727.529072965041;6736.528443008942;6742.056112144206;5208.687478751287;5309.070912590359;5353.2773075634295;5384.111621582395;5419.078756611464;5002.224655178453;5072.492750724898;5127.128388174094;5161.380634323905;5208.583313335 12:33:26 INFO - PID 3088 | |4;prototype.html;388.8794473713149;392.58778282803047;397.7434554712212;412.1797622730767;413.78689974663035;5381.542568881645;5425.104857698485;5450.1552259399805;5454;5455;5115.309433226514;5256.947430525694;5280.1815718563585;5281.762320695569;5340.839774806752;4040.5555388907196;4045.3325201341745;4045.5752146024683;4065.939010914831;4068.3897415387632;4028.6172813582807;4033.7781422021776;4047.575004624516;4053.4730485036903;4058.533268674096;3856.730028897978;4001.1797581495725;4009.7995100245016;4018.127039166995;4021.1153546219784;3981.741186822876;3987.282289187945;4006.0385507477995;4006.0986278087344;4009.396241503393;3527.7177825773874;3534.505169276303;3535.416656251741;3537.593176784677;3538.575370955476;4933.481984391659;5037.085907355218;5042.873928151789;5043.167877300241;5068.290439338495;4751.2724838785625;4763.523647635244;4776.402949631296;4782.880427989293;4783.402074740658;5599.076152434844;5610.719464026783;5615.971920140414;5620.606557540974;5622.409646987048;3993.1614360984227;3993.6206060424215;3997.34043882759;3999.1002024544246;4009.7794621295816;5668.68822214778;5680.4319568043275;5735.2257445245195;5800.59395842287;5939.465448109648;4070.6336429720873;4073.735207211522;4076.4496792932573;4082.2039702258367;4082.4284600156;4119.546849846514;4122.197639749658;4128.307393968458;4129.752214867118;4151.501819781585;4405.361222622766;4506.211413002777;4705.270683044134;4725.10223057618;4729.905401891943;5552.833414997475;5570.498655120978;5619.072852979212;5620.409856965041;5644.463775941279;1417.7944198091218;1421.7369786589513;1423.9359228834728;1428.1431141315336;1433.0398632915972;934.3086116273909;968.5786682793008;973.868527748759;987.0080569028081;987.2496902354119;4987.127252730757;4987.900241995139;4990.151674215392;4994.775235114428;5001.899962000813;5827.125931110368;5835.416458354215;5847.356790753014;5859.648421094748;5874.735636896265;4852.393450818648;4961.677490963076;4970.204767237225;4972.353594032825;4993.400791904995;3051.4965030770118;3070.370574032318;3079.5226739855357;3080.168354544305;3084.383123375334;5419.241306217133;5431.456854314616;5438.510534051875;5445.156000819879;5452.509274165344;5786.276715410574;5896.528277737771;5959.523238140939;5968.671723055274;5987.6888640179;5405.78376864921;5408.648437851527;5432.348118225759;5450.482204190595;5454.400015998237;5610.943890561042;5740.856478588069;5788.102844059177;5798.275215598051;5825.097109947965;5663.405342438985;5666.320041595035;5702.372738998624;5716.256886604715;5737.168110624019;5197.064528384927;5291.550218231493;5318.946810531846;5436.3476382834315;5452.563794896319;4064.4716186895516;4079.63283304504;4080.6737810211207;4099.1596722672375;4103;5870.773043408739;5875.559333050124;5883.735231914488;5884.6469211847425;5893.116032595145;5419.458054194549;5662.03745363281;5678.318601767649;5682.119271512922;5696.373398926032;5692.373838877803;5710.9428905712075;5717.571182161271;5719.170720245625;5723.197192884229;5417.593680473901;5641.774329026793;5646.85882852932;5654.264945557051;5662.178984047207;5661.0093233684765;5695;5709.7145142741865;5713;5734.7132643368495;5558.082916318762;5579.945758851529;5595.300587426572;5602.887942241214;5609.635373700697 12:33:26 INFO - PID 3088 | |5;yui.html;658.4633523678204;716.4197000429652;747.6598147842732;748.9251074892511;773.9496932699373;11774.82337764933;13731.862681373183;14304.642383940407;14352.64118397038;14448.277586120705;14405.063670861413;16378.262978165982;16401.83598164018;16538.09040502772;16564.917175414106;896.1934259166753;911.1708345405682;914.085914085914;914.5701520285455;915.281504019345;643.4659232836734;657.1489920552896;864.7967727584013;910.2172131966504;911.3256190419075;941.1153515695258;956.7034219391976;959.7984423271122;960.3085778239656;960.6541645007792;950.9619615215383;952.4570994533119;952.514217748953;953.2278854128109;953.3564843730454;698.3854208296717;699.6396855619361;699.6396855619361;699.912510936133;700.2157583506454;14815.259237038214;14861.851381486154;15070.09579425238;15111.848881511154;15275.541733747894;15386.99984501004;15620.843791562053;15770.290336934866;15772;15847.60380990473;12164.695882603006;12478;12518.12373133881;12654.367281635881;12663.493460261578;2765.225736793701;2765.9446811063667;2768.584712293152;2772.5286701260634;2778.583212518118;64282.35717642857;65415;65621;67227.66386168038;67355;10999.285046471954;11105.944470277758;11120.277181983145;11142.721431964266;11152.442377881236;16904.830951690572;17197.05416202121;17319.56701082458;17596.29614815393;17606.119694015248;6814.965925170342;6911.7926462206215;6915.446764258847;6922.307769223037;6926.411255043277;3649.069487280726;3714.53568303962;3719.5536535615356;3723.0134014486184;3725.515682961198;3566.8038257896064;3673.522442082512;3706.5366829146355;3709.276691045274;3733.439984002421;691.3294104718415;695.5548448992648;696.20632478974;696.4985210648325;697.4803771190495;552.494467562176;565.7341049706631;567.044529967007;567.6480582039162;568.196002656245;8891.510966896883;9127.452352858849;9236.214921731727;9307.348485605942;9343.112404321579;559.7653749385883;567.3192169396658;567.8921005009036;572.7852055479195;580.1877371679598;4485.071419289671;4507.932381014288;4509.887252818706;4555.544445555418;4629.51390104041;60929;61121.38878611157;61410.078848817306;61429.69285153546;63522.6823865887;53934;54122.72938635282;54259.72870135624;55351.44648553544;55529;48901;48962.75518622455;49219;49257.75371123121;49838.75080624646;7557.659905304165;9854.950725246328;9881.703548893545;10103.797924041331;10264.01720293106;25260;25471;25610;26445.60331594989;26467.60298595484;42733.07701153393;43531.78234108936;44088.55911440973;45740.54259457363;46014.769926150155;12577.87422125767;12908.612741617766;12940.547080852126;13086.541971031349;13100.344982750634;14182;14386.640333991734;14444.277786110863;14445.4944076961;14515.85484145145;12697.492100315883;12859.807102893652;13055.673608159872;13099.2140471572;13111.344432778515;13899.37452814646;13945.860541394457;14087.788683169556;14168.079074860101;14229.786553201917;13632;13717.45130194821;14367.568972930829;14524.782128268296;14704.779428308799;10094.495275236355;10265.12746416563;10458.320209186379;10544.103751181236;10937.890621093688;9997.350172238781;10431.68704938853;10471.581136754445;10866.076383507174;10878.075363594184 12:33:26 INFO - PID 3088 | __end_tp_report 12:33:26 INFO - PID 3088 | __start_cc_report 12:33:26 INFO - PID 3088 | _x_x_mozilla_cycle_collect,1540 12:33:26 INFO - PID 3088 | __end_cc_report 12:33:26 INFO - PID 3088 | __startTimestamp1491766406813__endTimestamp 12:33:26 INFO - PID 3088 | 12:33:26 INFO - PID 3088 | ------- Summary: start ------- 12:33:26 INFO - PID 3088 | Number of tests: 6 12:33:26 INFO - PID 3088 | 12:33:26 INFO - PID 3088 | [#0] dojo.html Cycles:165 Average:5309.06 Median:5464.56 stddev:621.72 (11.4%) stddev-sans-first:590.71 12:33:26 INFO - PID 3088 | Values: 2764.4 2789.1 2826.7 2827.7 2838.1 5242.1 5375.1 5383.5 5420.5 5458.6 5357.1 5361.5 5393.0 5454.8 5483.3 4783.2 4797.5 4798.1 4800.3 4849.1 4771.5 4818.7 4848.7 4852.6 4895.2 4695.6 4742.5 4766.0 4785.5 4843.1 4721.3 4724.6 4743.1 4788.4 4804.9 4699.2 4704.0 4711.5 4716.2 4752.4 5147.5 5208.6 5211.7 5234.4 5276.8 5657.1 5750.0 5764.1 5793.7 5890.2 5894.9 5898.9 5910.5 5913.5 5963.3 5442.2 5457.3 5462.6 5462.9 5467.4 5845.8 5879.0 5933.9 6008.5 6024.8 5724.4 5762.0 5767.5 5789.4 5792.7 5782.8 5836.3 5842.6 5845.5 5846.6 5733.2 5767.7 5776.9 5785.2 5787.9 5601.6 5685.5 5691.1 5695.5 5705.1 4939.1 4955.3 4958.0 4959.1 4963.4 4136.1 4201.3 4220.0 4252.6 4261.6 4966.9 4968.2 4968.6 4999.3 5004.2 5827.2 5839.5 5839.8 5841.6 5846.0 4775.2 4828.1 4960.3 4960.4 5001.5 5194.3 5203.8 5218.1 5223.5 5277.3 5464.6 5480.8 5521.6 5527.4 5532.9 5841.5 5853.7 5854.8 5855.5 5858.9 5382.6 5439.6 5451.2 5462.0 5466.5 5701.3 5726.5 5767.3 5772.7 5807.7 5809.3 5824.6 5827.2 5829.5 5834.0 5453.5 5563.4 5612.1 5618.2 5623.8 5523.9 5579.4 5589.4 5698.1 5705.1 5541.4 5542.5 5545.3 5590.0 5592.0 5648.1 5692.0 5696.5 5698.7 5713.6 5367.6 5411.5 5418.5 5421.9 5557.6 12:33:26 INFO - PID 3088 | 12:33:26 INFO - PID 3088 | [#1] ext.html Cycles:180 Average:31307.96 Median:3055.31 stddev:43663.54 (1429.1%) stddev-sans-first:43725.36 12:33:26 INFO - PID 3088 | Values: 656.0 703.2 723.7 1059.7 1072.0 26574.2 33601.5 34290.8 34383.7 34395.5 35626.1 35939.0 35961.0 35979.6 36112.3 7161.4 7308.8 7309.5 7309.7 7310.9 5537.2 5655.0 6996.3 7023.6 7049.7 7198.7 7256.9 7259.4 7259.9 7270.2 7117.3 7163.3 7194.4 7206.7 7215.6 7215.3 7263.4 7264.4 7264.9 7265.1 31733.0 31864.0 31885.2 31899.5 31915.2 3031.5 3041.0 3058.5 3062.0 3062.8 24288.0 24443.5 24467.4 24492.3 24500.9 3052.1 3086.5 3089.3 3095.2 3119.1 138343.3 138450.3 139222.0 139317.0 139849.0 41352.6 41494.2 41518.6 41550.4 41596.0 43621.3 43637.8 43684.6 43715.0 43781.1 12547.5 12635.7 12651.4 12656.6 12661.7 8666.9 10212.6 10220.7 10226.5 10266.6 10226.7 11463.7 11471.8 11715.6 11731.3 4888.3 4891.6 4902.6 4904.3 4921.5 897.8 908.9 926.2 947.4 948.6 20731.3 20786.2 21257.1 21272.6 21514.8 976.4 983.5 985.1 1003.6 1012.9 10732.6 11288.8 11296.2 11308.2 11481.9 183226.0 183286.0 183972.0 184365.0 184891.0 39564.8 39623.8 39776.2 39838.0 39865.0 1212.7 1255.0 1261.1 1265.6 1268.9 19518.4 19721.0 19920.8 20461.7 20961.8 27988.2 28158.3 28169.9 28185.3 28194.0 179638.0 179644.0 179733.0 179859.0 180621.0 27443.3 28017.0 28117.0 28201.7 28254.7 29525.1 30182.0 33384.7 34044.8 34539.3 26244.6 26321.0 26499.6 26795.6 26916.2 25602.4 25970.4 26153.6 26771.3 27255.0 29164.3 29274.6 33781.0 34643.1 34994.3 35249.1 36237.1 36259.5 36603.3 36613.5 26608.2 27162.3 28027.7 28066.4 28464.0 12:33:26 INFO - PID 3088 | 12:33:26 INFO - PID 3088 | [#2] jquery.html Cycles:180 Average:28900.48 Median:23072.34 stddev:80279.60 (347.9%) stddev-sans-first:80476.34 12:33:26 INFO - PID 3088 | Values: 427.6 428.5 429.5 441.8 446.1 16916.1 17506.3 18067.8 18182.6 18335.4 17562.8 17903.4 18625.8 18674.7 18769.2 5655.0 5669.0 5773.2 5816.2 5817.0 5641.7 5758.0 5771.0 5775.2 5776.4 5528.5 5662.0 5683.8 5700.5 5705.6 5628.0 5642.1 5661.2 5681.0 5687.7 5049.8 5175.3 5178.7 5212.6 5218.1 21520.8 21609.8 21721.3 21795.2 21879.7 1539.6 1573.6 1585.3 1586.3 1586.3 14130.2 14216.6 14297.6 14443.4 14518.1 2051.3 2090.5 2132.6 2137.4 2183.9 66730.7 80684.6 88688.6 88909.6 91592.5 10948.3 11218.7 11285.6 11439.6 11586.7 16014.4 16014.9 16036.2 16042.8 16051.3 7554.3 7727.5 7845.0 7921.0 7936.4 7017.2 7043.4 7116.8 7247.2 7285.3 7079.1 7080.3 7152.2 7231.1 7273.0 2015.9 2057.7 2071.1 2084.1 2118.0 859.4 865.8 894.3 900.8 918.0 17623.6 18110.4 18182.3 18259.8 18557.3 884.2 886.5 889.1 902.8 913.4 9637.6 11266.7 12338.3 12348.9 12399.9 472794.0 481738.0 487356.0 491932.0 496402.0 87764.0 92621.5 93332.0 95681.5 96221.0 1098.7 1117.0 1161.4 1162.5 1162.5 17462.2 17671.3 18204.9 19749.1 19781.7 43943.8 45698.5 45967.7 46993.2 47721.8 53839.0 55197.7 55781.0 56426.2 57185.7 7822.8 7896.0 7954.6 7962.9 8108.4 11553.4 11692.6 11766.3 12142.3 12216.2 10407.6 10407.9 10523.9 10601.8 10920.2 9773.4 10168.8 10284.0 10336.5 10342.1 9481.9 9513.9 9875.5 10036.8 10117.4 8039.6 8044.7 8200.3 8361.5 8454.9 10411.0 10475.6 10561.0 10667.1 10870.3 12:33:26 INFO - PID 3088 | 12:33:26 INFO - PID 3088 | [#3] mootools.html Cycles:180 Average:6402.56 Median:3944.07 stddev:4107.59 (104.1%) stddev-sans-first:4101.20 12:33:26 INFO - PID 3088 | Values: 1296.8 1368.9 1372.1 1385.7 1393.0 9368.5 9690.1 9695.5 9723.4 9742.6 10082.2 10471.7 10476.8 10480.3 10496.6 2298.2 2343.9 2346.7 2348.8 2352.8 2203.2 2309.6 2353.2 2353.2 2355.7 2282.2 2322.9 2337.3 2356.3 2367.8 2122.3 2235.2 2254.1 2254.8 2258.6 1882.7 1952.0 2213.3 2215.0 2222.0 10023.5 10384.2 10392.2 10392.5 10399.4 5690.4 5891.4 5914.1 5914.5 5917.8 2994.6 3132.0 3510.9 3589.1 3595.7 1132.0 1136.0 1145.6 1152.6 1162.0 14416.4 14615.8 14638.9 14653.5 14691.6 4915.5 5050.3 5138.3 5147.2 5175.7 11468.6 11482.7 11485.9 11492.6 11503.9 5831.0 5839.8 5844.2 5848.7 5850.4 5244.6 5400.8 5401.2 5481.6 5492.3 3876.5 4011.6 4020.4 4077.9 4085.2 1210.5 1226.6 1228.2 1235.4 1235.6 697.6 708.4 718.9 720.0 736.3 5310.2 5375.4 5420.5 5495.6 5516.9 535.4 542.2 554.1 554.5 558.6 3288.5 3608.2 3629.4 3636.3 3731.2 12678.6 13189.6 13265.0 13327.5 13899.9 13514.3 13547.1 13665.3 13674.9 13826.5 9723.8 9800.9 9906.4 9923.8 9962.2 5883.9 5948.5 6013.0 6017.1 6060.7 11966.8 12141.8 12206.6 12316.9 12375.6 12539.2 12539.7 12721.4 12873.9 12875.0 7711.8 7886.1 7893.4 7896.4 7897.1 9725.8 9744.6 9819.5 9830.4 9847.4 8270.9 8280.3 8379.9 8398.8 8487.7 8271.3 8282.0 8297.0 8366.1 8379.7 6574.9 6667.1 6727.5 6736.5 6742.1 5208.7 5309.1 5353.3 5384.1 5419.1 5002.2 5072.5 5127.1 5161.4 5208.6 12:33:26 INFO - PID 3088 | 12:33:26 INFO - PID 3088 | [#4] prototype.html Cycles:180 Average:4648.27 Median:5305.25 stddev:1365.37 (25.7%) stddev-sans-first:1331.25 12:33:26 INFO - PID 3088 | Values: 388.9 392.6 397.7 412.2 413.8 5381.5 5425.1 5450.2 5454.0 5455.0 5115.3 5256.9 5280.2 5281.8 5340.8 4040.6 4045.3 4045.6 4065.9 4068.4 4028.6 4033.8 4047.6 4053.5 4058.5 3856.7 4001.2 4009.8 4018.1 4021.1 3981.7 3987.3 4006.0 4006.1 4009.4 3527.7 3534.5 3535.4 3537.6 3538.6 4933.5 5037.1 5042.9 5043.2 5068.3 4751.3 4763.5 4776.4 4782.9 4783.4 5599.1 5610.7 5616.0 5620.6 5622.4 3993.2 3993.6 3997.3 3999.1 4009.8 5668.7 5680.4 5735.2 5800.6 5939.5 4070.6 4073.7 4076.4 4082.2 4082.4 4119.5 4122.2 4128.3 4129.8 4151.5 4405.4 4506.2 4705.3 4725.1 4729.9 5552.8 5570.5 5619.1 5620.4 5644.5 1417.8 1421.7 1423.9 1428.1 1433.0 934.3 968.6 973.9 987.0 987.2 4987.1 4987.9 4990.2 4994.8 5001.9 5827.1 5835.4 5847.4 5859.6 5874.7 4852.4 4961.7 4970.2 4972.4 4993.4 3051.5 3070.4 3079.5 3080.2 3084.4 5419.2 5431.5 5438.5 5445.2 5452.5 5786.3 5896.5 5959.5 5968.7 5987.7 5405.8 5408.6 5432.3 5450.5 5454.4 5610.9 5740.9 5788.1 5798.3 5825.1 5663.4 5666.3 5702.4 5716.3 5737.2 5197.1 5291.6 5318.9 5436.3 5452.6 4064.5 4079.6 4080.7 4099.2 4103.0 5870.8 5875.6 5883.7 5884.6 5893.1 5419.5 5662.0 5678.3 5682.1 5696.4 5692.4 5710.9 5717.6 5719.2 5723.2 5417.6 5641.8 5646.9 5654.3 5662.2 5661.0 5695.0 5709.7 5713.0 5734.7 5558.1 5579.9 5595.3 5602.9 5609.6 12:33:26 INFO - PID 3088 | 12:33:26 INFO - PID 3088 | [#5] yui.html Cycles:180 Average:14997.95 Median:23233.26 stddev:17578.58 (75.7%) stddev-sans-first:17594.91 12:33:26 INFO - PID 3088 | Values: 658.5 716.4 747.7 748.9 773.9 11774.8 13731.9 14304.6 14352.6 14448.3 14405.1 16378.3 16401.8 16538.1 16564.9 896.2 911.2 914.1 914.6 915.3 643.5 657.1 864.8 910.2 911.3 941.1 956.7 959.8 960.3 960.7 951.0 952.5 952.5 953.2 953.4 698.4 699.6 699.6 699.9 700.2 14815.3 14861.9 15070.1 15111.8 15275.5 15387.0 15620.8 15770.3 15772.0 15847.6 12164.7 12478.0 12518.1 12654.4 12663.5 2765.2 2765.9 2768.6 2772.5 2778.6 64282.4 65415.0 65621.0 67227.7 67355.0 10999.3 11105.9 11120.3 11142.7 11152.4 16904.8 17197.1 17319.6 17596.3 17606.1 6815.0 6911.8 6915.4 6922.3 6926.4 3649.1 3714.5 3719.6 3723.0 3725.5 3566.8 3673.5 3706.5 3709.3 3733.4 691.3 695.6 696.2 696.5 697.5 552.5 565.7 567.0 567.6 568.2 8891.5 9127.5 9236.2 9307.3 9343.1 559.8 567.3 567.9 572.8 580.2 4485.1 4507.9 4509.9 4555.5 4629.5 60929.0 61121.4 61410.1 61429.7 63522.7 53934.0 54122.7 54259.7 55351.4 55529.0 48901.0 48962.8 49219.0 49257.8 49838.8 7557.7 9855.0 9881.7 10103.8 10264.0 25260.0 25471.0 25610.0 26445.6 26467.6 42733.1 43531.8 44088.6 45740.5 46014.8 12577.9 12908.6 12940.5 13086.5 13100.3 14182.0 14386.6 14444.3 14445.5 14515.9 12697.5 12859.8 13055.7 13099.2 13111.3 13899.4 13945.9 14087.8 14168.1 14229.8 13632.0 13717.5 14367.6 14524.8 14704.8 10094.5 10265.1 10458.3 10544.1 10937.9 9997.4 10431.7 10471.6 10866.1 10878.1 12:33:26 INFO - PID 3088 | -------- Summary: end -------- 12:33:26 INFO - PID 3088 | 12:33:27 INFO - TEST-INFO | 3088: exit 0 12:33:27 INFO - TEST-OK | dromaeo_css | took 1124686ms 12:33:27 INFO - TEST-START | kraken 12:33:27 INFO - operating with platform_type : linux_ 12:33:27 INFO - Initialising browser for kraken test... 12:33:27 INFO - TEST-INFO | started process 3422 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMeaYwY/profile http://localhost:57342/getInfo.html) 12:33:32 INFO - PID 3422 | __metrics Screen width/height:1600/1200 12:33:32 INFO - PID 3422 | colorDepth:24 12:33:32 INFO - PID 3422 | Browser inner width/height: 1024/697 12:33:32 INFO - PID 3422 | __metrics 12:33:33 INFO - PID 3422 | 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" 12:33:33 INFO - PID 3422 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:33:34 INFO - TEST-INFO | 3422: exit 0 12:33:34 INFO - Browser initialized. 12:33:34 INFO - Running cycle 1/1 for kraken test... 12:33:34 INFO - TEST-INFO | started process 3519 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMeaYwY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:33:46 INFO - PID 3519 | RSS: Main: 171560960 12:33:46 INFO - PID 3519 | 12:33:49 INFO - PID 3519 | Cycle 1(1): loaded http://localhost:57342/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57342/tests/kraken/driver.html?testName=audio-beat-detection) 12:33:50 INFO - PID 3519 | RSS: Main: 232734720 12:33:50 INFO - PID 3519 | 12:33:53 INFO - PID 3519 | Cycle 1(1): loaded http://localhost:57342/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57342/tests/kraken/driver.html?testName=audio-dft) 12:33:53 INFO - PID 3519 | RSS: Main: 210530304 12:33:53 INFO - PID 3519 | 12:33:56 INFO - PID 3519 | Cycle 1(1): loaded http://localhost:57342/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57342/tests/kraken/driver.html?testName=audio-fft) 12:33:57 INFO - PID 3519 | RSS: Main: 294141952 12:33:57 INFO - PID 3519 | 12:33:59 INFO - PID 3519 | Cycle 1(1): loaded http://localhost:57342/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57342/tests/kraken/driver.html?testName=audio-oscillator) 12:34:00 INFO - PID 3519 | RSS: Main: 206655488 12:34:00 INFO - PID 3519 | 12:34:02 INFO - PID 3519 | Cycle 1(1): loaded http://localhost:57342/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57342/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:34:03 INFO - PID 3519 | RSS: Main: 209682432 12:34:03 INFO - PID 3519 | 12:34:06 INFO - PID 3519 | Cycle 1(1): loaded http://localhost:57342/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57342/tests/kraken/driver.html?testName=imaging-darkroom) 12:34:07 INFO - PID 3519 | RSS: Main: 246394880 12:34:07 INFO - PID 3519 | 12:34:10 INFO - PID 3519 | Cycle 1(1): loaded http://localhost:57342/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57342/tests/kraken/driver.html?testName=imaging-desaturate) 12:34:11 INFO - PID 3519 | RSS: Main: 241393664 12:34:11 INFO - PID 3519 | 12:34:14 INFO - PID 3519 | Cycle 1(1): loaded http://localhost:57342/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57342/tests/kraken/driver.html?testName=json-parse-financial) 12:34:14 INFO - PID 3519 | RSS: Main: 242085888 12:34:14 INFO - PID 3519 | 12:34:16 INFO - PID 3519 | Cycle 1(1): loaded http://localhost:57342/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57342/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:34:17 INFO - PID 3519 | RSS: Main: 207142912 12:34:17 INFO - PID 3519 | 12:34:19 INFO - PID 3519 | Cycle 1(1): loaded http://localhost:57342/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57342/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:34:19 INFO - PID 3519 | RSS: Main: 214798336 12:34:19 INFO - PID 3519 | 12:34:21 INFO - PID 3519 | Cycle 1(1): loaded http://localhost:57342/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57342/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:34:22 INFO - PID 3519 | RSS: Main: 223956992 12:34:22 INFO - PID 3519 | 12:34:25 INFO - PID 3519 | Cycle 1(1): loaded http://localhost:57342/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57342/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:34:26 INFO - PID 3519 | RSS: Main: 232574976 12:34:26 INFO - PID 3519 | 12:34:29 INFO - PID 3519 | Cycle 1(1): loaded http://localhost:57342/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57342/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:34:29 INFO - PID 3519 | RSS: Main: 229052416 12:34:29 INFO - PID 3519 | 12:34:31 INFO - PID 3519 | Cycle 1(1): loaded http://localhost:57342/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57342/tests/kraken/driver.html?testName=ai-astar) 12:34:31 INFO - PID 3519 | RSS: Main: 296382464 12:34:31 INFO - PID 3519 | 12:34:31 INFO - PID 3519 | __start_tp_report 12:34:31 INFO - PID 3519 | _x_x_mozilla_page_load 12:34:31 INFO - PID 3519 | _x_x_mozilla_page_load_details 12:34:31 INFO - PID 3519 | |i|pagename|runs| 12:34:31 INFO - PID 3519 | |0;ai-astar;104;112;113;121;116;116;119;119;118;116 12:34:31 INFO - PID 3519 | |1;audio-beat-detection;146;125;123;172;126;126;125;129;164;127 12:34:31 INFO - PID 3519 | |2;audio-dft;164;163;164;164;164;163;162;163;164;163 12:34:31 INFO - PID 3519 | |3;audio-fft;75;77;75;108;76;76;79;76;100;76 12:34:31 INFO - PID 3519 | |4;audio-oscillator;85;85;105;85;85;85;101;84;86;110 12:34:31 INFO - PID 3519 | |5;imaging-gaussian-blur;125;123;125;124;114;114;113;113;114;114 12:34:31 INFO - PID 3519 | |6;imaging-darkroom;150;151;151;151;151;152;154;151;150;150 12:34:31 INFO - PID 3519 | |7;imaging-desaturate;94;95;94;101;94;94;95;94;95;94 12:34:31 INFO - PID 3519 | |8;json-parse-financial;56;58;54;54;55;54;55;55;55;54 12:34:31 INFO - PID 3519 | |9;json-stringify-tinderbox;56;55;55;56;56;55;56;57;57;55 12:34:31 INFO - PID 3519 | |10;stanford-crypto-aes;85;83;93;92;84;83;82;83;84;82 12:34:31 INFO - PID 3519 | |11;stanford-crypto-ccm;137;134;145;143;133;132;134;141;183;141 12:34:31 INFO - PID 3519 | |12;stanford-crypto-pbkdf2;185;194;196;193;184;196;193;197;196;193 12:34:31 INFO - PID 3519 | |13;stanford-crypto-sha256-iterative;75;72;70;70;70;70;73;71;70;73 12:34:31 INFO - PID 3519 | __end_tp_report 12:34:31 INFO - PID 3519 | __start_cc_report 12:34:31 INFO - PID 3519 | _x_x_mozilla_cycle_collect,1987 12:34:31 INFO - PID 3519 | __end_cc_report 12:34:31 INFO - PID 3519 | __startTimestamp1491766471967__endTimestamp 12:34:31 INFO - PID 3519 | 12:34:31 INFO - PID 3519 | ------- Summary: start ------- 12:34:31 INFO - PID 3519 | Number of tests: 14 12:34:31 INFO - PID 3519 | 12:34:31 INFO - PID 3519 | [#0] ai-astar Cycles:10 Average:115.40 Median:117.00 stddev:4.86 (4.2%) stddev-sans-first:2.92 12:34:31 INFO - PID 3519 | Values: 104.0 112.0 113.0 121.0 116.0 116.0 119.0 119.0 118.0 116.0 12:34:31 INFO - PID 3519 | 12:34:31 INFO - PID 3519 | [#1] audio-beat-detection Cycles:10 Average:136.30 Median:128.00 stddev:18.01 (14.1%) stddev-sans-first:18.76 12:34:31 INFO - PID 3519 | Values: 146.0 125.0 123.0 172.0 126.0 126.0 125.0 129.0 164.0 127.0 12:34:31 INFO - PID 3519 | 12:34:31 INFO - PID 3519 | [#2] audio-dft Cycles:10 Average:163.40 Median:164.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 12:34:31 INFO - PID 3519 | Values: 164.0 163.0 164.0 164.0 164.0 163.0 162.0 163.0 164.0 163.0 12:34:31 INFO - PID 3519 | 12:34:31 INFO - PID 3519 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:11.91 (15.7%) stddev-sans-first:12.37 12:34:31 INFO - PID 3519 | Values: 75.0 77.0 75.0 108.0 76.0 76.0 79.0 76.0 100.0 76.0 12:34:31 INFO - PID 3519 | 12:34:31 INFO - PID 3519 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:85.00 stddev:10.06 (11.8%) stddev-sans-first:10.43 12:34:31 INFO - PID 3519 | Values: 85.0 85.0 105.0 85.0 85.0 85.0 101.0 84.0 86.0 110.0 12:34:31 INFO - PID 3519 | 12:34:31 INFO - PID 3519 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.50 stddev:5.51 (4.6%) stddev-sans-first:5.21 12:34:31 INFO - PID 3519 | Values: 125.0 123.0 125.0 124.0 114.0 114.0 113.0 113.0 114.0 114.0 12:34:31 INFO - PID 3519 | 12:34:31 INFO - PID 3519 | [#6] imaging-darkroom Cycles:10 Average:151.10 Median:151.00 stddev:1.20 (0.8%) stddev-sans-first:1.20 12:34:31 INFO - PID 3519 | Values: 150.0 151.0 151.0 151.0 151.0 152.0 154.0 151.0 150.0 150.0 12:34:31 INFO - PID 3519 | 12:34:31 INFO - PID 3519 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:94.00 stddev:2.16 (2.3%) stddev-sans-first:2.26 12:34:31 INFO - PID 3519 | Values: 94.0 95.0 94.0 101.0 94.0 94.0 95.0 94.0 95.0 94.0 12:34:31 INFO - PID 3519 | 12:34:31 INFO - PID 3519 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.00 stddev:1.25 (2.3%) stddev-sans-first:1.27 12:34:31 INFO - PID 3519 | Values: 56.0 58.0 54.0 54.0 55.0 54.0 55.0 55.0 55.0 54.0 12:34:31 INFO - PID 3519 | 12:34:31 INFO - PID 3519 | [#9] json-stringify-tinderbox Cycles:10 Average:55.80 Median:56.00 stddev:0.79 (1.4%) stddev-sans-first:0.83 12:34:31 INFO - PID 3519 | Values: 56.0 55.0 55.0 56.0 56.0 55.0 56.0 57.0 57.0 55.0 12:34:31 INFO - PID 3519 | 12:34:31 INFO - PID 3519 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:84.00 stddev:4.01 (4.8%) stddev-sans-first:4.26 12:34:31 INFO - PID 3519 | Values: 85.0 83.0 93.0 92.0 84.0 83.0 82.0 83.0 84.0 82.0 12:34:31 INFO - PID 3519 | 12:34:31 INFO - PID 3519 | [#11] stanford-crypto-ccm Cycles:10 Average:142.30 Median:141.00 stddev:15.00 (10.6%) stddev-sans-first:15.79 12:34:31 INFO - PID 3519 | Values: 137.0 134.0 145.0 143.0 133.0 132.0 134.0 141.0 183.0 141.0 12:34:31 INFO - PID 3519 | 12:34:31 INFO - PID 3519 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.70 Median:195.00 stddev:4.57 (2.3%) stddev-sans-first:3.91 12:34:31 INFO - PID 3519 | Values: 185.0 194.0 196.0 193.0 184.0 196.0 193.0 197.0 196.0 193.0 12:34:31 INFO - PID 3519 | 12:34:31 INFO - PID 3519 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.50 stddev:1.78 (2.5%) stddev-sans-first:1.32 12:34:31 INFO - PID 3519 | Values: 75.0 72.0 70.0 70.0 70.0 70.0 73.0 71.0 70.0 73.0 12:34:31 INFO - PID 3519 | -------- Summary: end -------- 12:34:31 INFO - PID 3519 | 12:34:33 INFO - TEST-INFO | 3519: exit 0 12:34:33 INFO - TEST-OK | kraken | took 65612ms 12:34:33 INFO - SUITE-END | took 1190s 12:34:33 INFO - Completed test suite (00:19:50) 12:34:33 INFO - javascript benchmark 12:34:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6767.592091760875, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2764.447110577885, 2789.065663002894, 2826.7173282671724, 2827.660680718313, 2838.091810620602, 5242.082635538784, 5375.086235339992, 5383.515483606475, 5420.457954204582, 5458.617896747224, 5357.11607584749, 5361.463853614647, 5393.029254734146, 5454.809081682142, 5483.314585676791, 4783.210770222909, 4797.472278049412, 4798.136335459616, 4800.279958006292, 4849.127157111719, 4771.475137734847, 4818.734969576672, 4848.660593758438, 4852.563269305761, 4895.241237608177, 4695.5539223773685, 4742.5020372861045, 4766.046790641885, 4785.49752276013, 4843.104025755229, 4721.26820342844, 4724.598409135193, 4743.146233677971, 4788.353572267734, 4804.903901921942, 4699.177643912336, 4703.976480117578, 4711.528847115261, 4716.245400735866, 4752.42970843501, 5147.510986456281, 5208.583313334924, 5211.687298762086, 5234.398044224887, 5276.7889284428575, 5657.066584013633, 5750.0, 5764.07774756037, 5793.710314484259, 5890.204822349014, 5894.852628684317, 5898.941010589882, 5910.468057874769, 5913.497352725023, 5963.314218864799, 5442.156465747816, 5457.317835270591, 5462.562994960394, 5462.945370546323, 5467.398586155519, 5845.766169353178, 5878.970605147032, 5933.881322373615, 6008.519318454513, 6024.789132380346, 5724.427557244242, 5762.0, 5767.480926716616, 5789.421057894177, 5792.681402522818, 5782.797602083907, 5836.270466191726, 5842.5618078644275, 5845.532357411397, 5846.619969701956, 5733.197352370671, 5767.711614419262, 5776.855578610568, 5785.1611516329895, 5787.942120578825, 5601.60788744784, 5685.459881311269, 5691.089425691952, 5695.515881150066, 5705.115707065412, 4939.061578300111, 4955.281484184845, 4957.983613359253, 4959.057779021974, 4963.354763880672, 4136.131412403429, 4201.306784380604, 4220.0, 4252.574742525722, 4261.573842615776, 4966.90066198674, 4968.205087186033, 4968.6025117990475, 4999.3000979862845, 5004.199328107486, 5827.242458480455, 5839.532837373, 5839.766409343579, 5841.649501029951, 5846.0, 4775.21209000518, 4828.082664293773, 4960.255961605716, 4960.404751429852, 5001.474845141208, 5194.298769666122, 5203.7918483261, 5218.060749065129, 5223.4776522347465, 5277.261183434322, 5464.562834973272, 5480.835574932758, 5521.585881058856, 5527.39198688152, 5532.944670553243, 5841.474267315962, 5853.678047707417, 5854.765809367577, 5855.531557475477, 5858.853528661817, 5382.569394448513, 5439.5920305978, 5451.236826844166, 5462.016836969384, 5466.535344495763, 5701.344345400166, 5726.484616384545, 5767.336756273083, 5772.682502462405, 5807.709614519342, 5809.2738407699035, 5824.5631577631, 5827.184194212899, 5829.504492118048, 5833.970830145822, 5453.481919217668, 5563.443655634404, 5612.074007788832, 5618.213450116905, 5623.831285061455, 5523.917141242804, 5579.4420557945505, 5589.389835749962, 5698.116791897262, 5705.087186050212, 5541.445855414427, 5542.473465020817, 5545.334559852843, 5589.972050139723, 5592.0, 5648.068068768772, 5691.971540142438, 5696.515796157208, 5698.743556539883, 5713.628614140068, 5367.624266301322, 5411.540019098421, 5418.512333889968, 5421.9186712200135, 5557.610967232255], "value": 5264.0712053014095, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [655.9803205903821, 703.1527009953006, 723.6851969393316, 1059.713877253142, 1072.0405237312605, 26574.20277391679, 33601.49597756033, 34290.828545857265, 34383.65616343836, 34395.484067738944, 35626.109347266334, 35939.0, 35961.0, 35979.640203597955, 36112.2777544449, 7161.427085833121, 7308.817279568, 7309.524880882752, 7309.67106480207, 7310.853782924339, 5537.224788529609, 5655.0386434306065, 6996.3003699630135, 7023.648817559101, 7049.718011279542, 7198.712051517933, 7256.927430725678, 7259.41924646027, 7259.927400725978, 7270.236625154362, 7117.288271172842, 7163.31948464895, 7194.424446044304, 7206.711731530732, 7215.639218039129, 7215.278472152795, 7263.418926485869, 7264.38252748517, 7264.891026634605, 7265.055542779458, 31733.0, 31864.0, 31885.202869928205, 31899.52150717741, 31915.202119946956, 3031.4846476098896, 3040.9847950760327, 3058.541218817173, 3061.9846900765356, 3062.8009179403266, 24288.0, 24443.511129777304, 24467.388315292083, 24492.265232043068, 24500.877495612585, 3052.0700127877262, 3086.4752991991413, 3089.2894634234026, 3095.2107212660853, 3119.111053349807, 138343.30828345794, 138450.30774846062, 139222.0, 139316.99999999898, 139849.0, 41352.55266065673, 41494.1701165981, 41518.58481415147, 41550.37674434886, 41596.0, 43621.345679814825, 43637.78181109138, 43684.56315436868, 43715.0, 43781.12437751291, 12547.498100076078, 12635.684107897192, 12651.430685619169, 12656.620301390973, 12661.683457913441, 8666.913330866611, 10212.591496340212, 10220.744481387876, 10226.488675566192, 10266.58933642646, 10226.693199204035, 11463.713407164887, 11471.827922581168, 11715.648530544097, 11731.296122232694, 4888.26675998596, 4891.633127515451, 4902.583280421204, 4904.2643603459765, 4921.532454416824, 897.82043591282, 908.8727578139066, 926.2358554192817, 947.4220725357526, 948.6442584030989, 20731.27440539574, 20786.168553258, 21257.149714011575, 21272.574548509252, 21514.78485215159, 976.3751199232497, 983.4590974963742, 985.0838719990478, 1003.6386900715737, 1012.9240306977006, 10732.624358147428, 11288.830667539993, 11296.152788540729, 11308.208425410143, 11481.88518114825, 183226.0, 183286.0, 183972.0, 184365.0, 184891.0, 39564.80217598894, 39623.839496852415, 39776.20447591032, 39838.0, 39865.0, 1212.7089498520293, 1255.0022731928138, 1261.066810560179, 1265.5950095969201, 1268.9048321375749, 19518.414447566596, 19721.0, 19920.800791991893, 20461.693074603594, 20961.790382096595, 27988.16035518938, 28158.2960425991, 28169.859150704116, 28185.295367615152, 28194.0, 179638.0, 179644.0, 179733.0, 179859.0, 180621.0, 27443.31391715223, 28017.0, 28117.0, 28201.717982819908, 28254.717452825207, 29525.114246572637, 30182.0, 33384.666153338156, 34044.829775850965, 34539.30921381609, 26244.606330905433, 26321.0, 26499.60250596204, 26795.598066029415, 26916.192514224604, 25602.35994100088, 25970.35074123162, 26153.60769588496, 26771.33071673146, 27255.0, 29164.27089322784, 29274.560881586367, 33781.0, 34643.13392165216, 34994.300113998084, 35249.126420347784, 36237.0940726484, 36259.45610815893, 36603.26793464169, 36613.450798238584, 26608.20175394741, 27162.320941975817, 28027.66444422347, 28066.438671226868, 28464.0], "value": 14654.365911428744, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [427.6300999635316, 428.5414606371183, 429.4742608933848, 441.79898146343413, 446.1367254362808, 16916.069616171106, 17506.29974801008, 18067.81932180678, 18182.636347273048, 18335.358262460817, 17562.82437175628, 17903.373381931637, 18625.813741862577, 18674.719879201824, 18769.155388007537, 5654.971725141369, 5669.036263835148, 5773.249477567911, 5816.185733997244, 5817.0, 5641.717914104299, 5758.0, 5771.018926782436, 5775.2203452534, 5776.39347868474, 5528.5024347808685, 5662.0, 5683.801066962657, 5700.543956483492, 5705.62913410627, 5628.0, 5642.125470552071, 5661.1508273758855, 5681.0, 5687.658740475585, 5049.798008079672, 5175.327207463006, 5178.715170665612, 5212.582993360522, 5218.086834803894, 21520.784792152033, 21609.783902160936, 21721.34835954924, 21795.23716669909, 21879.67180492278, 1539.5612250508552, 1573.6301969037268, 1585.2786981923198, 1586.2623879895905, 1586.2861712229542, 14130.22283774392, 14216.573502794932, 14297.642558936006, 14443.422263109464, 14518.128912265192, 2051.2820512820545, 2090.4773806548365, 2132.616129096762, 2137.444264491228, 2183.923562675299, 66730.66634666844, 80684.59657701732, 88688.5565572168, 88909.55545222296, 91592.54203729006, 10948.288361256493, 11218.719532011602, 11285.614315705256, 11439.59961401347, 11586.652400428, 16014.439494617633, 16014.919925400298, 16036.198190090448, 16042.75935860963, 16051.277692503865, 7554.2823431773895, 7727.459077864608, 7844.960775196201, 7921.0, 7936.444448888637, 7017.193022802443, 7043.401310888529, 7116.750913717995, 7247.20280769115, 7285.307895749896, 7079.115110611174, 7080.327368899946, 7152.249013853574, 7231.132264128339, 7272.96363518179, 2015.9496012599802, 2057.6913462980374, 2071.1197740960033, 2084.0725876984598, 2117.9576408472053, 859.4155973937783, 865.8181781825762, 894.2935081285841, 900.7708807150366, 917.9541022948825, 17623.647527049387, 18110.366137185134, 18182.272709091754, 18259.817401826076, 18557.25770969146, 884.1688812516214, 886.5079880666163, 889.1242126505387, 902.7521471535829, 913.4382354851718, 9637.614495420245, 11266.7183320416, 12338.259704417584, 12348.88860002604, 12399.938000309941, 472794.0, 481738.0, 487356.0, 491932.0, 496402.0, 87764.0, 92621.53689231511, 93332.0, 95681.5215923916, 96221.0, 1098.6594155811724, 1116.966491005255, 1161.372858656316, 1162.4536467860091, 1162.5175552145934, 17462.206047032414, 17671.293148273926, 18204.908975455037, 19749.1112899917, 19781.70327445118, 43943.78028109839, 45698.543014569426, 45967.72580935464, 46993.24054075734, 47721.76139119282, 53839.0, 55197.72401137969, 55781.0, 56426.153607695094, 57185.71407142938, 7822.765317040498, 7896.0, 7954.5624990623755, 7962.880556791537, 8108.432409731262, 11553.364564949008, 11692.590759323382, 11766.294022358687, 12142.271463712206, 12216.205946613798, 10407.58369665205, 10407.895921040692, 10523.894761052597, 10601.787964240517, 10920.235583509078, 9773.41359518431, 10168.847467288144, 10284.0, 10336.483175841027, 10342.069213770495, 9481.905180948102, 9513.904860951301, 9875.456849873326, 10036.799264014824, 10117.392956422638, 8039.638216280398, 8044.678212871654, 8200.26197642215, 8361.540115293717, 8454.873176902229, 10411.0, 10475.58097676115, 10561.049505544537, 10667.093297069525, 10870.34777913296], "value": 9116.96274290785, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1296.805479178123, 1368.9041767076303, 1372.053283234568, 1385.7436374270767, 1392.97910531342, 9368.531573421327, 9690.079442452974, 9695.515224238796, 9723.416595004286, 9742.610295588176, 10082.243831712633, 10471.73820654484, 10476.790464190712, 10480.318779279341, 10496.632617858377, 2298.2071185441037, 2343.9414014649683, 2346.7301260355107, 2348.765123487646, 2352.8235382346306, 2203.162798136706, 2309.607366747657, 2353.1646265575732, 2353.2234362660365, 2355.7290911545133, 2282.2126366403645, 2322.918697845576, 2337.2520793346134, 2356.2577787996725, 2367.7987371073477, 2122.3420739570784, 2235.228846048111, 2254.132159118743, 2254.785795349439, 2258.559580881737, 1882.6517094337455, 1952.0337432970628, 2213.2806837777625, 2214.970038931888, 2222.0, 10023.49882505879, 10384.221183411275, 10392.220583456272, 10392.53233604482, 10399.428031458267, 5690.378242200953, 5891.440313170242, 5914.083317085859, 5914.4676979071655, 5917.792877249319, 2994.610700608907, 3131.968680313213, 3510.8771193008124, 3589.10272431892, 3595.7123430125525, 1132.0, 1135.9545618175264, 1145.5909231645123, 1152.5793085523808, 1161.96514104577, 14416.351264193136, 14615.78076328856, 14638.853611463855, 14653.487127950577, 14691.63270918225, 4915.48387419323, 5050.292958985671, 5138.254953031864, 5147.1507201312115, 5175.663581867167, 11468.598599048993, 11482.712932176595, 11485.942570287096, 11492.597759078391, 11503.942480287713, 5830.970845145832, 5839.766409343663, 5844.152597873284, 5848.678322692293, 5850.385709500441, 5244.5527351161445, 5400.756965936543, 5401.243825864382, 5481.561475081984, 5492.313460817398, 3876.5154355705536, 4011.618896204856, 4020.43713880057, 4077.918441631151, 4085.2442298174337, 1210.509743553862, 1226.589092653971, 1228.2078059651474, 1235.4440501774238, 1235.567551357018, 697.5988806436319, 708.4155571653406, 718.867009603225, 719.9784006479814, 736.3078706016328, 5310.176922577007, 5375.354957405137, 5420.512153906088, 5495.6153069284765, 5516.91724624131, 535.3843080457505, 542.2435702195415, 554.0691638048118, 554.4677109974389, 558.5782734035777, 3288.5067239914206, 3608.224231790178, 3629.4192929131214, 3636.3272794533095, 3731.197792474631, 12678.591067697109, 13189.604311870658, 13265.0, 13327.466901324033, 13899.86100139006, 13514.32428378577, 13547.119437236548, 13665.316734163252, 13674.93162534181, 13826.516071937434, 9723.805523889483, 9800.852987205197, 9906.405615663083, 9923.751906202402, 9962.203023758082, 5883.94116058834, 5948.464638182411, 6013.0, 6017.097435384552, 6060.696950155561, 11966.760664786829, 12141.817872731739, 12206.633800985985, 12316.876831231573, 12375.566855160027, 12539.184952978027, 12539.651808717983, 12721.427535760728, 12873.935630321788, 12875.034372421918, 7711.807204819925, 7886.132525422085, 7893.447458678067, 7896.447248692536, 7897.052353717361, 9725.756856078655, 9744.561494732896, 9819.509024548886, 9830.361026533252, 9847.409155450408, 8270.875936861072, 8280.296174824967, 8379.916200837913, 8398.832023359377, 8487.745367638981, 8271.296939760188, 8281.95859020701, 8297.0, 8366.079731229682, 8379.664813407395, 6574.934250657432, 6667.133272674521, 6727.529072965041, 6736.528443008942, 6742.056112144206, 5208.687478751287, 5309.070912590359, 5353.2773075634295, 5384.111621582395, 5419.078756611464, 5002.224655178453, 5072.492750724898, 5127.128388174094, 5161.380634323905, 5208.583313335], "value": 4789.646318581231, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.8794473713149, 392.58778282803047, 397.7434554712212, 412.1797622730767, 413.78689974663035, 5381.542568881645, 5425.104857698485, 5450.1552259399805, 5454.0, 5455.0, 5115.309433226514, 5256.947430525694, 5280.1815718563585, 5281.762320695569, 5340.839774806752, 4040.5555388907196, 4045.3325201341745, 4045.5752146024683, 4065.939010914831, 4068.3897415387632, 4028.6172813582807, 4033.7781422021776, 4047.575004624516, 4053.4730485036903, 4058.533268674096, 3856.730028897978, 4001.1797581495725, 4009.7995100245016, 4018.127039166995, 4021.1153546219784, 3981.741186822876, 3987.282289187945, 4006.0385507477995, 4006.0986278087344, 4009.396241503393, 3527.7177825773874, 3534.505169276303, 3535.416656251741, 3537.593176784677, 3538.575370955476, 4933.481984391659, 5037.085907355218, 5042.873928151789, 5043.167877300241, 5068.290439338495, 4751.2724838785625, 4763.523647635244, 4776.402949631296, 4782.880427989293, 4783.402074740658, 5599.076152434844, 5610.719464026783, 5615.971920140414, 5620.606557540974, 5622.409646987048, 3993.1614360984227, 3993.6206060424215, 3997.34043882759, 3999.1002024544246, 4009.7794621295816, 5668.68822214778, 5680.4319568043275, 5735.2257445245195, 5800.59395842287, 5939.465448109648, 4070.6336429720873, 4073.735207211522, 4076.4496792932573, 4082.2039702258367, 4082.4284600156, 4119.546849846514, 4122.197639749658, 4128.307393968458, 4129.752214867118, 4151.501819781585, 4405.361222622766, 4506.211413002777, 4705.270683044134, 4725.10223057618, 4729.905401891943, 5552.833414997475, 5570.498655120978, 5619.072852979212, 5620.409856965041, 5644.463775941279, 1417.7944198091218, 1421.7369786589513, 1423.9359228834728, 1428.1431141315336, 1433.0398632915972, 934.3086116273909, 968.5786682793008, 973.868527748759, 987.0080569028081, 987.2496902354119, 4987.127252730757, 4987.900241995139, 4990.151674215392, 4994.775235114428, 5001.899962000813, 5827.125931110368, 5835.416458354215, 5847.356790753014, 5859.648421094748, 5874.735636896265, 4852.393450818648, 4961.677490963076, 4970.204767237225, 4972.353594032825, 4993.400791904995, 3051.4965030770118, 3070.370574032318, 3079.5226739855357, 3080.168354544305, 3084.383123375334, 5419.241306217133, 5431.456854314616, 5438.510534051875, 5445.156000819879, 5452.509274165344, 5786.276715410574, 5896.528277737771, 5959.523238140939, 5968.671723055274, 5987.6888640179, 5405.78376864921, 5408.648437851527, 5432.348118225759, 5450.482204190595, 5454.400015998237, 5610.943890561042, 5740.856478588069, 5788.102844059177, 5798.275215598051, 5825.097109947965, 5663.405342438985, 5666.320041595035, 5702.372738998624, 5716.256886604715, 5737.168110624019, 5197.064528384927, 5291.550218231493, 5318.946810531846, 5436.3476382834315, 5452.563794896319, 4064.4716186895516, 4079.63283304504, 4080.6737810211207, 4099.1596722672375, 4103.0, 5870.773043408739, 5875.559333050124, 5883.735231914488, 5884.6469211847425, 5893.116032595145, 5419.458054194549, 5662.03745363281, 5678.318601767649, 5682.119271512922, 5696.373398926032, 5692.373838877803, 5710.9428905712075, 5717.571182161271, 5719.170720245625, 5723.197192884229, 5417.593680473901, 5641.774329026793, 5646.85882852932, 5654.264945557051, 5662.178984047207, 5661.0093233684765, 5695.0, 5709.7145142741865, 5713.0, 5734.7132643368495, 5558.082916318762, 5579.945758851529, 5595.300587426572, 5602.887942241214, 5609.635373700697], "value": 4235.590552973962, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [658.4633523678204, 716.4197000429652, 747.6598147842732, 748.9251074892511, 773.9496932699373, 11774.82337764933, 13731.862681373183, 14304.642383940407, 14352.64118397038, 14448.277586120705, 14405.063670861413, 16378.262978165982, 16401.83598164018, 16538.09040502772, 16564.917175414106, 896.1934259166753, 911.1708345405682, 914.085914085914, 914.5701520285455, 915.281504019345, 643.4659232836734, 657.1489920552896, 864.7967727584013, 910.2172131966504, 911.3256190419075, 941.1153515695258, 956.7034219391976, 959.7984423271122, 960.3085778239656, 960.6541645007792, 950.9619615215383, 952.4570994533119, 952.514217748953, 953.2278854128109, 953.3564843730454, 698.3854208296717, 699.6396855619361, 699.6396855619361, 699.912510936133, 700.2157583506454, 14815.259237038214, 14861.851381486154, 15070.09579425238, 15111.848881511154, 15275.541733747894, 15386.99984501004, 15620.843791562053, 15770.290336934866, 15772.0, 15847.60380990473, 12164.695882603006, 12478.0, 12518.12373133881, 12654.367281635881, 12663.493460261578, 2765.225736793701, 2765.9446811063667, 2768.584712293152, 2772.5286701260634, 2778.583212518118, 64282.35717642857, 65415.0, 65621.0, 67227.66386168038, 67355.0, 10999.285046471954, 11105.944470277758, 11120.277181983145, 11142.721431964266, 11152.442377881236, 16904.830951690572, 17197.05416202121, 17319.56701082458, 17596.29614815393, 17606.119694015248, 6814.965925170342, 6911.7926462206215, 6915.446764258847, 6922.307769223037, 6926.411255043277, 3649.069487280726, 3714.53568303962, 3719.5536535615356, 3723.0134014486184, 3725.515682961198, 3566.8038257896064, 3673.522442082512, 3706.5366829146355, 3709.276691045274, 3733.439984002421, 691.3294104718415, 695.5548448992648, 696.20632478974, 696.4985210648325, 697.4803771190495, 552.494467562176, 565.7341049706631, 567.044529967007, 567.6480582039162, 568.196002656245, 8891.510966896883, 9127.452352858849, 9236.214921731727, 9307.348485605942, 9343.112404321579, 559.7653749385883, 567.3192169396658, 567.8921005009036, 572.7852055479195, 580.1877371679598, 4485.071419289671, 4507.932381014288, 4509.887252818706, 4555.544445555418, 4629.51390104041, 60929.0, 61121.38878611157, 61410.078848817306, 61429.69285153546, 63522.6823865887, 53934.0, 54122.72938635282, 54259.72870135624, 55351.44648553544, 55529.0, 48901.0, 48962.75518622455, 49219.0, 49257.75371123121, 49838.75080624646, 7557.659905304165, 9854.950725246328, 9881.703548893545, 10103.797924041331, 10264.01720293106, 25260.0, 25471.0, 25610.0, 26445.60331594989, 26467.60298595484, 42733.07701153393, 43531.78234108936, 44088.55911440973, 45740.54259457363, 46014.769926150155, 12577.87422125767, 12908.612741617766, 12940.547080852126, 13086.541971031349, 13100.344982750634, 14182.0, 14386.640333991734, 14444.277786110863, 14445.4944076961, 14515.85484145145, 12697.492100315883, 12859.807102893652, 13055.673608159872, 13099.2140471572, 13111.344432778515, 13899.37452814646, 13945.860541394457, 14087.788683169556, 14168.079074860101, 14229.786553201917, 13632.0, 13717.45130194821, 14367.568972930829, 14524.782128268296, 14704.779428308799, 10094.495275236355, 10265.12746416563, 10458.320209186379, 10544.103751181236, 10937.890621093688, 9997.350172238781, 10431.68704938853, 10471.581136754445, 10866.076383507174, 10878.075363594184], "value": 6733.117997321674, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1554.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 113.0, 121.0, 116.0, 116.0, 119.0, 119.0, 118.0, 116.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 125.0, 123.0, 172.0, 126.0, 126.0, 125.0, 129.0, 164.0, 127.0], "value": 136.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 163.0, 164.0, 164.0, 164.0, 163.0, 162.0, 163.0, 164.0, 163.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 75.0, 108.0, 76.0, 76.0, 79.0, 76.0, 100.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 105.0, 85.0, 85.0, 85.0, 101.0, 84.0, 86.0, 110.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 123.0, 125.0, 124.0, 114.0, 114.0, 113.0, 113.0, 114.0, 114.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 151.0, 151.0, 151.0, 151.0, 152.0, 154.0, 151.0, 150.0, 150.0], "value": 151.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 94.0, 101.0, 94.0, 94.0, 95.0, 94.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 58.0, 54.0, 54.0, 55.0, 54.0, 55.0, 55.0, 55.0, 54.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 55.0, 56.0, 56.0, 55.0, 56.0, 57.0, 57.0, 55.0], "value": 55.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 93.0, 92.0, 84.0, 83.0, 82.0, 83.0, 84.0, 82.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 134.0, 145.0, 143.0, 133.0, 132.0, 134.0, 141.0, 183.0, 141.0], "value": 142.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 194.0, 196.0, 193.0, 184.0, 196.0, 193.0, 197.0, 196.0, 193.0], "value": 192.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 72.0, 70.0, 70.0, 70.0, 70.0, 73.0, 71.0, 70.0, 73.0], "value": 71.4, "unit": "score"}]}]} 12:34:33 INFO - Return code: 0 12:34:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:34:33 ERROR - # TBPL SUCCESS # 12:34:33 INFO - Running post-action listener: _resource_record_post_action 12:34:33 INFO - [mozharness: 2017-04-09 19:34:33.755555Z] Finished run-tests step (success) 12:34:33 INFO - Running post-run listener: _resource_record_post_run 12:34:33 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 0; Write bytes: 362270720; Read time: 0; Write time: 231320 12:34:33 INFO - TinderboxPrint: CPU usage
13.0% 12:34:33 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 12:34:33 INFO - TinderboxPrint: I/O write bytes / time
362,270,720 / 231,320 12:34:33 INFO - TinderboxPrint: CPU idle
8,372.1 (87.0%) 12:34:33 INFO - TinderboxPrint: CPU user
1,206.0 (12.5%) 12:34:33 INFO - TinderboxPrint: Swap in / out
0 / 0 12:34:33 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 103301120; Read time: 0; Write time: 88488 12:34:33 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 258969600; Read time: 0; Write time: 142832 12:34:34 INFO - Running post-run listener: _upload_blobber_files 12:34:34 INFO - Blob upload gear active. 12:34:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:34:34 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 12:34:34 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'] 12:34:34 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 12:34:34 INFO - (blobuploader) - INFO - Open directory for files ... 12:34:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:34:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:34:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:34:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:34:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:34:35 INFO - (blobuploader) - INFO - Done attempting. 12:34:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 12:34:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:34:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:34:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 12:34:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:34:36 INFO - (blobuploader) - INFO - Done attempting. 12:34:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:34:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:34:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:34:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:34:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:34:37 INFO - (blobuploader) - INFO - Done attempting. 12:34:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:34:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:34:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:34:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:34:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:34:40 INFO - (blobuploader) - INFO - Done attempting. 12:34:40 INFO - (blobuploader) - INFO - Iteration through files over. 12:34:40 INFO - Return code: 0 12:34:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:34:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:34:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49fa1be9a74fb912c171b1e6edeec3825f5cbe2f7e590624681a11f755f0ddccc07a9b0805f21ec0736c1bf95367c1ebe8bbcf15965e6ace5e319ad3b95ddc91", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90fa08bf1b49d2e61e5d980128e7cd0a8de20385310db1d34bd6c952e31bdee8b74c73e3b270bdea2154c139a51ed9fc8a1d15f93bb3d27d932f84ce4d766421", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d0f7a77a5202b5491821be12960548aae944754519b79cadb5515b454d28348ec8129b0f778176a38ff7e93367d0893dd3af4a270c115d706eecfc8dcc1a08d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc9ce2ff050e3935283fc031f8060a0fd822cf66827c1e1da82154e1efe7ab7e4bc0c1da0212f033e513de33dad5acc2a10c1a6d4755975a77fb467201f4b160"} 12:34:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:34:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:34:40 INFO - Contents: 12:34:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49fa1be9a74fb912c171b1e6edeec3825f5cbe2f7e590624681a11f755f0ddccc07a9b0805f21ec0736c1bf95367c1ebe8bbcf15965e6ace5e319ad3b95ddc91", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90fa08bf1b49d2e61e5d980128e7cd0a8de20385310db1d34bd6c952e31bdee8b74c73e3b270bdea2154c139a51ed9fc8a1d15f93bb3d27d932f84ce4d766421", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d0f7a77a5202b5491821be12960548aae944754519b79cadb5515b454d28348ec8129b0f778176a38ff7e93367d0893dd3af4a270c115d706eecfc8dcc1a08d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc9ce2ff050e3935283fc031f8060a0fd822cf66827c1e1da82154e1efe7ab7e4bc0c1da0212f033e513de33dad5acc2a10c1a6d4755975a77fb467201f4b160"} 12:34:40 INFO - Running post-run listener: copy_logs_to_upload_dir 12:34:40 INFO - Copying logs to upload dir... 12:34:40 INFO - mkdir: /builds/slave/test/build/upload/logs 12:34:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.804899 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-04-09 12:34:39.371121) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-09 12:34:39.374580) ========= 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=7de08804244eb36560b44971000001c3-1491764897.971542-71221440 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/49fa1be9a74fb912c171b1e6edeec3825f5cbe2f7e590624681a11f755f0ddccc07a9b0805f21ec0736c1bf95367c1ebe8bbcf15965e6ace5e319ad3b95ddc91", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90fa08bf1b49d2e61e5d980128e7cd0a8de20385310db1d34bd6c952e31bdee8b74c73e3b270bdea2154c139a51ed9fc8a1d15f93bb3d27d932f84ce4d766421", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d0f7a77a5202b5491821be12960548aae944754519b79cadb5515b454d28348ec8129b0f778176a38ff7e93367d0893dd3af4a270c115d706eecfc8dcc1a08d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc9ce2ff050e3935283fc031f8060a0fd822cf66827c1e1da82154e1efe7ab7e4bc0c1da0212f033e513de33dad5acc2a10c1a6d4755975a77fb467201f4b160"} build_url:https://queue.taskcluster.net/v1/task/EDYNlfHKRrKT8I4EvF1W4Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011328 build_url: 'https://queue.taskcluster.net/v1/task/EDYNlfHKRrKT8I4EvF1W4Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/49fa1be9a74fb912c171b1e6edeec3825f5cbe2f7e590624681a11f755f0ddccc07a9b0805f21ec0736c1bf95367c1ebe8bbcf15965e6ace5e319ad3b95ddc91", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90fa08bf1b49d2e61e5d980128e7cd0a8de20385310db1d34bd6c952e31bdee8b74c73e3b270bdea2154c139a51ed9fc8a1d15f93bb3d27d932f84ce4d766421", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7d0f7a77a5202b5491821be12960548aae944754519b79cadb5515b454d28348ec8129b0f778176a38ff7e93367d0893dd3af4a270c115d706eecfc8dcc1a08d", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dc9ce2ff050e3935283fc031f8060a0fd822cf66827c1e1da82154e1efe7ab7e4bc0c1da0212f033e513de33dad5acc2a10c1a6d4755975a77fb467201f4b160"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-09 12:34:39.401242) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:34:39.401602) ========= 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=7de08804244eb36560b44971000001c3-1491764897.971542-71221440 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004377 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-09 12:34:39.485000) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-09 12:34:39.485355) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-09 12:34:39.485676) ========= ========= Total master_lag: 0.17 =========