builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-089 starttime: 1493697702.28 results: success (0) revision: 2e7c10a9b86e30691f67855f6c8f98d984508d7c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-01 21:01:42.284868) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-01 21:01:42.285622) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-01 21:01:42.286423) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-01 21:01:42.311406) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 21:01:42.311703) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-01 21:01:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.5M=0s 2017-05-01 21:01:43 (46.5 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.106287 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 21:01:42.436201) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 21:01:42.436506) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016902 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 21:01:42.488040) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 21:01:42.488926) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2e7c10a9b86e30691f67855f6c8f98d984508d7c --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 2e7c10a9b86e30691f67855f6c8f98d984508d7c --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=8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-01 21:01:43,670 truncating revision to first 12 chars 2017-05-01 21:01:43,670 Setting DEBUG logging. 2017-05-01 21:01:43,670 attempt 1/10 2017-05-01 21:01:43,670 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2e7c10a9b86e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-01 21:01:43,964 unpacking tar archive at: mozilla-central-2e7c10a9b86e/testing/mozharness/ program finished with exit code 0 elapsedTime=0.611578 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 21:01:43.114961) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-01 21:01:43.115327) ========= script_repo_revision: 2e7c10a9b86e30691f67855f6c8f98d984508d7c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-01 21:01:43.115790) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-01 21:01:43.116093) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-01 21:01:43.126832) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-05-01 21:01:43.127137) ========= /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=8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:01:44 INFO - MultiFileLogger online at 20170501 21:01:44 in /builds/slave/test 21:01:44 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 21:01:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:01:44 INFO - {'append_to_log': False, 21:01:44 INFO - 'base_work_dir': '/builds/slave/test', 21:01:44 INFO - 'blob_upload_branch': 'Firefox', 21:01:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:01:44 INFO - 'branch': 'Firefox', 21:01:44 INFO - 'buildbot_json_path': 'buildprops.json', 21:01:44 INFO - 'config_files': ('talos/linux_config.py',), 21:01:44 INFO - 'default_actions': ('clobber', 21:01:44 INFO - 'read-buildbot-config', 21:01:44 INFO - 'download-and-extract', 21:01:44 INFO - 'populate-webroot', 21:01:44 INFO - 'create-virtualenv', 21:01:44 INFO - 'install', 21:01:44 INFO - 'run-tests'), 21:01:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:01:44 INFO - 'download_minidump_stackwalk': True, 21:01:44 INFO - 'download_symbols': 'ondemand', 21:01:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:01:44 INFO - 'tooltool.py': '/tools/tooltool.py', 21:01:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:01:44 INFO - '/tools/misc-python/virtualenv.py')}, 21:01:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:01:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:01:44 INFO - 'gecko_profile': False, 21:01:44 INFO - 'gecko_profile_interval': 0, 21:01:44 INFO - 'installer_path': 'installer.exe', 21:01:44 INFO - 'log_level': 'info', 21:01:44 INFO - 'log_name': 'talos', 21:01:44 INFO - 'log_to_console': True, 21:01:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:01:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:01:44 INFO - 'opt_config_files': (), 21:01:44 INFO - 'pip_index': False, 21:01:44 INFO - 'suite': 'dromaeojs', 21:01:44 INFO - 'system_bits': '32', 21:01:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:01:44 INFO - 'title': 'talos-linux64-ix-089', 21:01:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:01:44 INFO - 'use_talos_json': True, 21:01:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:01:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:01:44 INFO - 'work_dir': 'build'} 21:01:44 INFO - [mozharness: 2017-05-02 04:01:44.410345Z] Running clobber step. 21:01:44 INFO - Running pre-action listener: _resource_record_pre_action 21:01:44 INFO - Running main action method: clobber 21:01:44 INFO - rmtree: /builds/slave/test/build 21:01:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:01:45 INFO - Running post-action listener: _resource_record_post_action 21:01:45 INFO - [mozharness: 2017-05-02 04:01:45.390876Z] Finished clobber step (success) 21:01:45 INFO - [mozharness: 2017-05-02 04:01:45.390995Z] Running read-buildbot-config step. 21:01:45 INFO - Running pre-action listener: _resource_record_pre_action 21:01:45 INFO - Running main action method: read_buildbot_config 21:01:45 INFO - Using buildbot properties: 21:01:45 INFO - { 21:01:45 INFO - "project": "", 21:01:45 INFO - "product": "firefox", 21:01:45 INFO - "who": "ihsiao@mozilla.com", 21:01:45 INFO - "installer_path": "public/build/target.tar.bz2", 21:01:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 21:01:45 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 21:01:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 21:01:45 INFO - "stage_platform": "linux64-pgo", 21:01:45 INFO - "basedir": "/builds/slave/test", 21:01:45 INFO - "buildnumber": 163, 21:01:45 INFO - "platform": "ubuntu64_hw", 21:01:45 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:01:45 INFO - "slavebuilddir": "test", 21:01:45 INFO - "taskId": "agSOZ2aETXGk2ARENILmuA", 21:01:45 INFO - "branch": "mozilla-central", 21:01:45 INFO - "script_repo_revision": "production", 21:01:45 INFO - "revision": "2e7c10a9b86e30691f67855f6c8f98d984508d7c", 21:01:45 INFO - "slavename": "talos-linux64-ix-089", 21:01:45 INFO - "repo_path": "mozilla-central" 21:01:45 INFO - } 21:01:45 INFO - Finding installer, test and symbols from parent task. 21:01:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/agSOZ2aETXGk2ARENILmuA'}, attempt #1 21:01:45 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/agSOZ2aETXGk2ARENILmuA'}, attempt #1 21:01:46 INFO - Task dependencies: OtmnlyVqTSqBJbbsibWJ-Q 21:01:46 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OtmnlyVqTSqBJbbsibWJ-Q'}, attempt #1 21:01:46 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/OtmnlyVqTSqBJbbsibWJ-Q/artifacts/public/build/target.tar.bz2 21:01:46 INFO - Set test_url: https://queue.taskcluster.net/v1/task/OtmnlyVqTSqBJbbsibWJ-Q/artifacts/public/build/test_packages.json 21:01:46 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/OtmnlyVqTSqBJbbsibWJ-Q/artifacts/public/build/target.crashreporter-symbols.zip 21:01:46 INFO - Running post-action listener: _resource_record_post_action 21:01:46 INFO - [mozharness: 2017-05-02 04:01:46.730180Z] Finished read-buildbot-config step (success) 21:01:46 INFO - [mozharness: 2017-05-02 04:01:46.730400Z] Running download-and-extract step. 21:01:46 INFO - Running pre-action listener: _resource_record_pre_action 21:01:46 INFO - Running main action method: download_and_extract 21:01:46 INFO - mkdir: /builds/slave/test/build/tests 21:01:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:01:46 INFO - trying https://queue.taskcluster.net/v1/task/OtmnlyVqTSqBJbbsibWJ-Q/artifacts/public/build/target.test_packages.json 21:01:46 INFO - Downloading https://queue.taskcluster.net/v1/task/OtmnlyVqTSqBJbbsibWJ-Q/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:01:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OtmnlyVqTSqBJbbsibWJ-Q/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:01:47 INFO - Downloaded 986 bytes. 21:01:47 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:01:47 INFO - Using the following test package requirements: 21:01:47 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 21:01:47 INFO - u'common': [u'target.common.tests.zip'], 21:01:47 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:01:47 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:01:47 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:01:47 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:01:47 INFO - u'mozbase': [u'target.common.tests.zip'], 21:01:47 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:01:47 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:01:47 INFO - u'web-platform': [u'target.common.tests.zip', 21:01:47 INFO - u'target.web-platform.tests.zip'], 21:01:47 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:01:47 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 21:01:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OtmnlyVqTSqBJbbsibWJ-Q/artifacts/public/build/target.common.tests.zip 21:01:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OtmnlyVqTSqBJbbsibWJ-Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:01:47 INFO - Fetch https://queue.taskcluster.net/v1/task/OtmnlyVqTSqBJbbsibWJ-Q/artifacts/public/build/target.common.tests.zip into memory 21:01:48 INFO - Content-Length response header: 60559385 21:01:48 INFO - Bytes received: 60559385 21:01:58 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 21:01:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OtmnlyVqTSqBJbbsibWJ-Q/artifacts/public/build/target.common.tests.zip 21:01:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OtmnlyVqTSqBJbbsibWJ-Q/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:01:58 INFO - Fetch https://queue.taskcluster.net/v1/task/OtmnlyVqTSqBJbbsibWJ-Q/artifacts/public/build/target.common.tests.zip into memory 21:01:59 INFO - Content-Length response header: 60559385 21:01:59 INFO - Bytes received: 60559385 21:02:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OtmnlyVqTSqBJbbsibWJ-Q/artifacts/public/build/target.talos.tests.zip 21:02:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OtmnlyVqTSqBJbbsibWJ-Q/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:02:10 INFO - Fetch https://queue.taskcluster.net/v1/task/OtmnlyVqTSqBJbbsibWJ-Q/artifacts/public/build/target.talos.tests.zip into memory 21:02:11 INFO - Content-Length response header: 14408811 21:02:11 INFO - Bytes received: 14408811 21:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:11 INFO - trying https://queue.taskcluster.net/v1/task/OtmnlyVqTSqBJbbsibWJ-Q/artifacts/public/build/target.tar.bz2 21:02:11 INFO - Downloading https://queue.taskcluster.net/v1/task/OtmnlyVqTSqBJbbsibWJ-Q/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:02:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OtmnlyVqTSqBJbbsibWJ-Q/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:02:12 INFO - Downloaded 64044402 bytes. 21:02:12 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OtmnlyVqTSqBJbbsibWJ-Q/artifacts/public/build/target.tar.bz2 21:02:12 INFO - mkdir: /builds/slave/test/properties 21:02:12 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:02:12 INFO - Writing to file /builds/slave/test/properties/build_url 21:02:12 INFO - Contents: 21:02:12 INFO - build_url:https://queue.taskcluster.net/v1/task/OtmnlyVqTSqBJbbsibWJ-Q/artifacts/public/build/target.tar.bz2 21:02:12 INFO - Running post-action listener: _resource_record_post_action 21:02:12 INFO - Running post-action listener: set_extra_try_arguments 21:02:12 INFO - [mozharness: 2017-05-02 04:02:12.439259Z] Finished download-and-extract step (success) 21:02:12 INFO - [mozharness: 2017-05-02 04:02:12.439356Z] Running populate-webroot step. 21:02:12 INFO - Running pre-action listener: _resource_record_pre_action 21:02:12 INFO - Running main action method: populate_webroot 21:02:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:02:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:02:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:02:12 INFO - '--tppagecycles', 21:02:12 INFO - '7'], 21:02:12 INFO - 'tests': ['tsvgm']}}, 21:02:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:02:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:02:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:02:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:02:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:02:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:02:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:02:12 INFO - 'talos_options': ['--disable-e10s'], 21:02:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:02:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:02:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:02:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:02:12 INFO - 'talos_options': ['--disable-e10s'], 21:02:12 INFO - 'tests': ['damp', 'tps']}, 21:02:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:02:12 INFO - 'tests': ['damp', 'tps']}, 21:02:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:02:12 INFO - 'tests': ['dromaeo_dom']}, 21:02:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:02:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:02:12 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 21:02:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:02:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:02:12 INFO - 'tests': ['a11yr', 21:02:12 INFO - 'ts_paint', 21:02:12 INFO - 'tpaint', 21:02:12 INFO - 'sessionrestore', 21:02:12 INFO - 'sessionrestore_no_auto_restore', 21:02:12 INFO - 'tabpaint']}, 21:02:12 INFO - 'other-e10s': {'tests': ['a11yr', 21:02:12 INFO - 'ts_paint', 21:02:12 INFO - 'tpaint', 21:02:12 INFO - 'sessionrestore', 21:02:12 INFO - 'sessionrestore_no_auto_restore', 21:02:12 INFO - 'tabpaint']}, 21:02:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:02:12 INFO - 'ts_paint', 21:02:12 INFO - 'tpaint', 21:02:12 INFO - 'sessionrestore', 21:02:12 INFO - 'sessionrestore_no_auto_restore', 21:02:12 INFO - 'tabpaint']}, 21:02:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:02:12 INFO - 'ts_paint', 21:02:12 INFO - 'tpaint', 21:02:12 INFO - 'sessionrestore', 21:02:12 INFO - 'sessionrestore_no_auto_restore', 21:02:12 INFO - 'tabpaint']}, 21:02:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:02:12 INFO - 'tests': ['a11yr', 21:02:12 INFO - 'ts_paint', 21:02:12 INFO - 'tpaint', 21:02:12 INFO - 'sessionrestore', 21:02:12 INFO - 'sessionrestore_no_auto_restore', 21:02:12 INFO - 'tabpaint']}, 21:02:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:02:12 INFO - 'tests': ['a11yr', 21:02:12 INFO - 'ts_paint', 21:02:12 INFO - 'tpaint', 21:02:12 INFO - 'sessionrestore', 21:02:12 INFO - 'sessionrestore_no_auto_restore', 21:02:12 INFO - 'tabpaint']}, 21:02:12 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 21:02:12 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 21:02:12 INFO - 'bloom_basic_ref']}, 21:02:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:02:12 INFO - 'tests': ['tsvgx', 21:02:12 INFO - 'tsvgr_opacity', 21:02:12 INFO - 'tart', 21:02:12 INFO - 'tscrollx', 21:02:12 INFO - 'cart', 21:02:12 INFO - 'tsvg_static']}, 21:02:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:02:12 INFO - 'tsvgr_opacity', 21:02:12 INFO - 'tart', 21:02:12 INFO - 'tscrollx', 21:02:12 INFO - 'cart', 21:02:12 INFO - 'tsvg_static']}, 21:02:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:02:12 INFO - 'talos_options': ['--disable-e10s'], 21:02:12 INFO - 'tests': ['tp5o']}, 21:02:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:02:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:02:12 INFO - 'talos_options': ['--disable-e10s', 21:02:12 INFO - '--xperf_path', 21:02:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:02:12 INFO - 'tests': ['tp5n']}, 21:02:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:02:12 INFO - 'talos_options': ['--xperf_path', 21:02:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:02:12 INFO - 'tests': ['tp5n']}}, 21:02:12 INFO - 'talos.zip': {'path': '', 21:02:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:02:12 INFO - Running post-action listener: _resource_record_post_action 21:02:12 INFO - [mozharness: 2017-05-02 04:02:12.453142Z] Finished populate-webroot step (success) 21:02:12 INFO - [mozharness: 2017-05-02 04:02:12.453232Z] Running create-virtualenv step. 21:02:12 INFO - Running pre-action listener: _resource_record_pre_action 21:02:12 INFO - Running main action method: create_virtualenv 21:02:12 INFO - Creating virtualenv /builds/slave/test/build/venv 21:02:12 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:02:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:02:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:02:12 INFO - Using real prefix '/usr' 21:02:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:02:13 INFO - Installing distribute.............................................................................................................................................................................................done. 21:02:15 INFO - Installing pip.................done. 21:02:15 INFO - Return code: 0 21:02:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:02:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:02:15 INFO - Reading from file tmpfile_stdout 21:02:15 INFO - Output received: 21:02:15 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:02:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:02: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')]} 21:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02: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')]} 21:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa400>, '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 0x1cfb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfb840>, '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': '8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:02: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', 'pip>=1.5'] in /builds/slave/test/build 21:02: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 pip>=1.5 21:02:15 INFO - Using env: {'DISPLAY': ':0', 21:02:15 INFO - 'HOME': '/home/cltbld', 21:02:15 INFO - 'LANG': 'en_US.UTF-8', 21:02:15 INFO - 'LANGUAGE': 'en_US:en', 21:02:15 INFO - 'LOGNAME': 'cltbld', 21:02:15 INFO - 'MAIL': '/var/mail/cltbld', 21:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:15 INFO - 'MOZ_NO_REMOTE': '1', 21:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:15 INFO - 'NO_EM_RESTART': '1', 21:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:15 INFO - 'PWD': '/builds/slave/test', 21:02:15 INFO - 'SHELL': '/bin/bash', 21:02:15 INFO - 'SHLVL': '1', 21:02:15 INFO - 'TERM': 'linux', 21:02:15 INFO - 'TMOUT': '86400', 21:02:15 INFO - 'USER': 'cltbld', 21:02:15 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006', 21:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:15 INFO - '_': '/tools/buildbot/bin/python'} 21:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:15 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:02:15 INFO - Cleaning up... 21:02:15 INFO - Return code: 0 21:02:15 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:02: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')]} 21:02:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02: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')]} 21:02:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02: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', '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 0x1a5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa400>, '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 0x1cfb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfb840>, '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': '8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:02: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', 'psutil>=3.1.1'] in /builds/slave/test/build 21:02: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 psutil>=3.1.1 21:02:15 INFO - Using env: {'DISPLAY': ':0', 21:02:15 INFO - 'HOME': '/home/cltbld', 21:02:15 INFO - 'LANG': 'en_US.UTF-8', 21:02:15 INFO - 'LANGUAGE': 'en_US:en', 21:02:15 INFO - 'LOGNAME': 'cltbld', 21:02:15 INFO - 'MAIL': '/var/mail/cltbld', 21:02:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:15 INFO - 'MOZ_NO_REMOTE': '1', 21:02:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:15 INFO - 'NO_EM_RESTART': '1', 21:02:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:15 INFO - 'PWD': '/builds/slave/test', 21:02:15 INFO - 'SHELL': '/bin/bash', 21:02:15 INFO - 'SHLVL': '1', 21:02:15 INFO - 'TERM': 'linux', 21:02:15 INFO - 'TMOUT': '86400', 21:02:15 INFO - 'USER': 'cltbld', 21:02:15 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006', 21:02:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:15 INFO - '_': '/tools/buildbot/bin/python'} 21:02:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:15 INFO - Downloading/unpacking psutil>=3.1.1 21:02: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 21:02: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 21:02: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 21:02: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 21:02: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 21:02: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 21:02:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:02:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:02:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:02:17 INFO - Installing collected packages: psutil 21:02:17 INFO - Running setup.py install for psutil 21:02:17 INFO - building 'psutil._psutil_linux' extension 21:02:17 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:02:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:02:18 INFO - building 'psutil._psutil_posix' extension 21:02:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:02:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:02:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:02:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:02:18 INFO - Successfully installed psutil 21:02:18 INFO - Cleaning up... 21:02:18 INFO - Return code: 0 21:02:18 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:02: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')]} 21:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02: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')]} 21:02:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:18 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 0x1a5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa400>, '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 0x1cfb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfb840>, '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': '8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:02:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:02:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:02:18 INFO - Using env: {'DISPLAY': ':0', 21:02:18 INFO - 'HOME': '/home/cltbld', 21:02:18 INFO - 'LANG': 'en_US.UTF-8', 21:02:18 INFO - 'LANGUAGE': 'en_US:en', 21:02:18 INFO - 'LOGNAME': 'cltbld', 21:02:18 INFO - 'MAIL': '/var/mail/cltbld', 21:02:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:18 INFO - 'MOZ_NO_REMOTE': '1', 21:02:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:18 INFO - 'NO_EM_RESTART': '1', 21:02:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:18 INFO - 'PWD': '/builds/slave/test', 21:02:18 INFO - 'SHELL': '/bin/bash', 21:02:18 INFO - 'SHLVL': '1', 21:02:18 INFO - 'TERM': 'linux', 21:02:18 INFO - 'TMOUT': '86400', 21:02:18 INFO - 'USER': 'cltbld', 21:02:18 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006', 21:02:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:18 INFO - '_': '/tools/buildbot/bin/python'} 21:02:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:02:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:02:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:02:20 INFO - Installing collected packages: mozsystemmonitor 21:02:20 INFO - Running setup.py install for mozsystemmonitor 21:02:20 INFO - Successfully installed mozsystemmonitor 21:02:20 INFO - Cleaning up... 21:02:21 INFO - Return code: 0 21:02:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:02: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')]} 21:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02: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')]} 21:02:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:21 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 0x1a5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa400>, '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 0x1cfb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfb840>, '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': '8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:02:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:02:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:02:21 INFO - Using env: {'DISPLAY': ':0', 21:02:21 INFO - 'HOME': '/home/cltbld', 21:02:21 INFO - 'LANG': 'en_US.UTF-8', 21:02:21 INFO - 'LANGUAGE': 'en_US:en', 21:02:21 INFO - 'LOGNAME': 'cltbld', 21:02:21 INFO - 'MAIL': '/var/mail/cltbld', 21:02:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:21 INFO - 'MOZ_NO_REMOTE': '1', 21:02:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:21 INFO - 'NO_EM_RESTART': '1', 21:02:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:21 INFO - 'PWD': '/builds/slave/test', 21:02:21 INFO - 'SHELL': '/bin/bash', 21:02:21 INFO - 'SHLVL': '1', 21:02:21 INFO - 'TERM': 'linux', 21:02:21 INFO - 'TMOUT': '86400', 21:02:21 INFO - 'USER': 'cltbld', 21:02:21 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006', 21:02:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:21 INFO - '_': '/tools/buildbot/bin/python'} 21:02:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:21 INFO - Downloading/unpacking jsonschema==2.5.1 21:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:02:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:02: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 21:02: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 21:02: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 21:02: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 21:02: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 21:02: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 21:02:23 INFO - Downloading functools32-3.2.3-2.tar.gz 21:02:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:02:23 INFO - warning: no files found matching '*.txt' 21:02:23 INFO - no previously-included directories found matching 'build' 21:02:23 INFO - no previously-included directories found matching 'dist' 21:02:23 INFO - no previously-included directories found matching '.git*' 21:02:23 INFO - Installing collected packages: jsonschema, functools32 21:02:23 INFO - Running setup.py install for functools32 21:02:23 INFO - warning: no files found matching '*.txt' 21:02:23 INFO - no previously-included directories found matching 'build' 21:02:23 INFO - no previously-included directories found matching 'dist' 21:02:23 INFO - no previously-included directories found matching '.git*' 21:02:23 INFO - Successfully installed jsonschema functools32 21:02:23 INFO - Cleaning up... 21:02:23 INFO - Return code: 0 21:02:23 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:02:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:23 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 0x1a5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa400>, '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 0x1cfb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfb840>, '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': '8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:02:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:02:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:02:23 INFO - Using env: {'DISPLAY': ':0', 21:02:23 INFO - 'HOME': '/home/cltbld', 21:02:23 INFO - 'LANG': 'en_US.UTF-8', 21:02:23 INFO - 'LANGUAGE': 'en_US:en', 21:02:23 INFO - 'LOGNAME': 'cltbld', 21:02:23 INFO - 'MAIL': '/var/mail/cltbld', 21:02:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:23 INFO - 'MOZ_NO_REMOTE': '1', 21:02:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:23 INFO - 'NO_EM_RESTART': '1', 21:02:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:23 INFO - 'PWD': '/builds/slave/test', 21:02:23 INFO - 'SHELL': '/bin/bash', 21:02:23 INFO - 'SHLVL': '1', 21:02:23 INFO - 'TERM': 'linux', 21:02:23 INFO - 'TMOUT': '86400', 21:02:23 INFO - 'USER': 'cltbld', 21:02:23 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006', 21:02:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:23 INFO - '_': '/tools/buildbot/bin/python'} 21:02:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:23 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:02:23 INFO - Cleaning up... 21:02:23 INFO - Return code: 0 21:02:23 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:02:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:23 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 0x1a5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa400>, '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 0x1cfb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfb840>, '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': '8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:02:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:02:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:02:23 INFO - Using env: {'DISPLAY': ':0', 21:02:23 INFO - 'HOME': '/home/cltbld', 21:02:23 INFO - 'LANG': 'en_US.UTF-8', 21:02:23 INFO - 'LANGUAGE': 'en_US:en', 21:02:23 INFO - 'LOGNAME': 'cltbld', 21:02:23 INFO - 'MAIL': '/var/mail/cltbld', 21:02:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:23 INFO - 'MOZ_NO_REMOTE': '1', 21:02:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:23 INFO - 'NO_EM_RESTART': '1', 21:02:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:23 INFO - 'PWD': '/builds/slave/test', 21:02:23 INFO - 'SHELL': '/bin/bash', 21:02:23 INFO - 'SHLVL': '1', 21:02:23 INFO - 'TERM': 'linux', 21:02:23 INFO - 'TMOUT': '86400', 21:02:23 INFO - 'USER': 'cltbld', 21:02:23 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006', 21:02:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:23 INFO - '_': '/tools/buildbot/bin/python'} 21:02:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:24 INFO - Downloading/unpacking blobuploader==1.2.4 21:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:26 INFO - Downloading blobuploader-1.2.4.tar.gz 21:02:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:02:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:02:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:26 INFO - Downloading docopt-0.6.1.tar.gz 21:02:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:02:26 INFO - Installing collected packages: blobuploader, requests, docopt 21:02:26 INFO - Running setup.py install for blobuploader 21:02:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:02:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:02:27 INFO - Running setup.py install for requests 21:02:27 INFO - Running setup.py install for docopt 21:02:27 INFO - Successfully installed blobuploader requests docopt 21:02:27 INFO - Cleaning up... 21:02:27 INFO - Return code: 0 21:02:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:27 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 0x1a5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa400>, '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 0x1cfb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfb840>, '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': '8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:02:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:02:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:02:27 INFO - Using env: {'DISPLAY': ':0', 21:02:27 INFO - 'HOME': '/home/cltbld', 21:02:27 INFO - 'LANG': 'en_US.UTF-8', 21:02:27 INFO - 'LANGUAGE': 'en_US:en', 21:02:27 INFO - 'LOGNAME': 'cltbld', 21:02:27 INFO - 'MAIL': '/var/mail/cltbld', 21:02:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:27 INFO - 'MOZ_NO_REMOTE': '1', 21:02:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:27 INFO - 'NO_EM_RESTART': '1', 21:02:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:27 INFO - 'PWD': '/builds/slave/test', 21:02:27 INFO - 'SHELL': '/bin/bash', 21:02:27 INFO - 'SHLVL': '1', 21:02:27 INFO - 'TERM': 'linux', 21:02:27 INFO - 'TMOUT': '86400', 21:02:27 INFO - 'USER': 'cltbld', 21:02:27 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006', 21:02:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:27 INFO - '_': '/tools/buildbot/bin/python'} 21:02:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:02:27 INFO - Running setup.py (path:/tmp/pip-QJdcln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:02:27 INFO - Running setup.py (path:/tmp/pip-ITvMKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:02:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:02:27 INFO - Running setup.py (path:/tmp/pip-CmvD5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:02:28 INFO - Running setup.py (path:/tmp/pip-WtDw4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:02:28 INFO - Running setup.py (path:/tmp/pip-ZVmivO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:02:28 INFO - Running setup.py (path:/tmp/pip-a2upa0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:02:28 INFO - Running setup.py (path:/tmp/pip-OS89wJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:02:28 INFO - Running setup.py (path:/tmp/pip-0ogD1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:02:28 INFO - Running setup.py (path:/tmp/pip-n0Absm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:02:28 INFO - Running setup.py (path:/tmp/pip-IypgAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:02:28 INFO - Running setup.py (path:/tmp/pip-gJhIgG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:02:28 INFO - Running setup.py (path:/tmp/pip-rqLIRz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:02:28 INFO - Running setup.py (path:/tmp/pip-wK21cB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:02:28 INFO - Running setup.py (path:/tmp/pip-5P_7E1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:02:28 INFO - Running setup.py (path:/tmp/pip-V1Be1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:02:28 INFO - Running setup.py (path:/tmp/pip-JUHH5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:02:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:02:28 INFO - Running setup.py (path:/tmp/pip-rn2akX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:02:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:02:29 INFO - Running setup.py install for manifestparser 21:02:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:02:29 INFO - Running setup.py install for mozcrash 21:02:29 INFO - Running setup.py install for mozdebug 21:02:29 INFO - Running setup.py install for mozdevice 21:02:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:02:29 INFO - Running setup.py install for mozfile 21:02:29 INFO - Running setup.py install for mozhttpd 21:02:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:02:29 INFO - Running setup.py install for mozinfo 21:02:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:02:29 INFO - Running setup.py install for mozInstall 21:02:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:02:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:02:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:02:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:02:29 INFO - Running setup.py install for mozleak 21:02:29 INFO - Running setup.py install for mozlog 21:02:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:02:30 INFO - Running setup.py install for moznetwork 21:02:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:02:30 INFO - Running setup.py install for mozprocess 21:02:30 INFO - Running setup.py install for mozprofile 21:02:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:02:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:02:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:02:30 INFO - Running setup.py install for mozrunner 21:02:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:02:30 INFO - Running setup.py install for mozscreenshot 21:02:30 INFO - Running setup.py install for moztest 21:02:30 INFO - Running setup.py install for mozversion 21:02:30 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:02:30 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:02:30 INFO - Cleaning up... 21:02:30 INFO - Return code: 0 21:02:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:30 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 0x1a5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa400>, '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 0x1cfb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfb840>, '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': '8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:02:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:02:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:02:30 INFO - Using env: {'DISPLAY': ':0', 21:02:30 INFO - 'HOME': '/home/cltbld', 21:02:30 INFO - 'LANG': 'en_US.UTF-8', 21:02:30 INFO - 'LANGUAGE': 'en_US:en', 21:02:30 INFO - 'LOGNAME': 'cltbld', 21:02:30 INFO - 'MAIL': '/var/mail/cltbld', 21:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:30 INFO - 'MOZ_NO_REMOTE': '1', 21:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:30 INFO - 'NO_EM_RESTART': '1', 21:02:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:30 INFO - 'PWD': '/builds/slave/test', 21:02:30 INFO - 'SHELL': '/bin/bash', 21:02:30 INFO - 'SHLVL': '1', 21:02:30 INFO - 'TERM': 'linux', 21:02:30 INFO - 'TMOUT': '86400', 21:02:30 INFO - 'USER': 'cltbld', 21:02:30 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006', 21:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:30 INFO - '_': '/tools/buildbot/bin/python'} 21:02:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:02:31 INFO - Running setup.py (path:/tmp/pip-cDK5OW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:02:31 INFO - Running setup.py (path:/tmp/pip-7vg_yZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:02:31 INFO - Running setup.py (path:/tmp/pip-ywFw_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:02:31 INFO - Running setup.py (path:/tmp/pip-NZEQCm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:02:31 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)) 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:02:31 INFO - Running setup.py (path:/tmp/pip-RQugNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:02:31 INFO - Running setup.py (path:/tmp/pip-JNGBvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:02:31 INFO - Running setup.py (path:/tmp/pip-VFCI1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:02:31 INFO - Running setup.py (path:/tmp/pip-PQclRK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:02:31 INFO - Running setup.py (path:/tmp/pip-__oF7l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:02:31 INFO - Running setup.py (path:/tmp/pip-vfnmiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:02:31 INFO - Running setup.py (path:/tmp/pip-GNynUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:02:31 INFO - Running setup.py (path:/tmp/pip-kgMEhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:02:31 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)) 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:02:31 INFO - Running setup.py (path:/tmp/pip-pXHDtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:02:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:02:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:02:31 INFO - Running setup.py (path:/tmp/pip-j6I1pY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:02:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:02:32 INFO - Running setup.py (path:/tmp/pip-DXzBQu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:02:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:02:32 INFO - Running setup.py (path:/tmp/pip-_Gw0Ma-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:02:32 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)) 21:02:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:02:32 INFO - Running setup.py (path:/tmp/pip-JFSjDV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:02:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:02:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:02:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:02:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:02:32 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)) 21:02:32 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)) 21:02:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:34 INFO - Downloading blessings-1.6.tar.gz 21:02:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:02:34 INFO - Installing collected packages: blessings 21:02:34 INFO - Running setup.py install for blessings 21:02:34 INFO - Successfully installed blessings 21:02:34 INFO - Cleaning up... 21:02:34 INFO - Return code: 0 21:02:34 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:02:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:02:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:02:34 INFO - Reading from file tmpfile_stdout 21:02:34 INFO - Current package versions: 21:02:34 INFO - argparse == 1.2.1 21:02:34 INFO - blessings == 1.6 21:02:34 INFO - blobuploader == 1.2.4 21:02:34 INFO - docopt == 0.6.1 21:02:34 INFO - functools32 == 3.2.3-2 21:02:34 INFO - jsonschema == 2.5.1 21:02:34 INFO - manifestparser == 1.1 21:02:34 INFO - mozInstall == 1.12 21:02:34 INFO - mozcrash == 1.0 21:02:34 INFO - mozdebug == 0.1 21:02:34 INFO - mozdevice == 0.50 21:02:34 INFO - mozfile == 1.2 21:02:34 INFO - mozhttpd == 0.7 21:02:34 INFO - mozinfo == 0.9 21:02:34 INFO - mozleak == 0.1 21:02:34 INFO - mozlog == 3.4 21:02:34 INFO - moznetwork == 0.27 21:02:34 INFO - mozprocess == 0.25 21:02:34 INFO - mozprofile == 0.28 21:02:34 INFO - mozrunner == 6.13 21:02:34 INFO - mozscreenshot == 0.1 21:02:34 INFO - mozsystemmonitor == 0.3 21:02:34 INFO - moztest == 0.8 21:02:34 INFO - mozversion == 1.4 21:02:34 INFO - psutil == 3.1.1 21:02:34 INFO - requests == 1.2.3 21:02:34 INFO - wsgiref == 0.1.2 21:02:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:02:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:34 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 0x1a5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa400>, '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 0x1cfb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfb840>, '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': '8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:02:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:02:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:02:34 INFO - Using env: {'DISPLAY': ':0', 21:02:34 INFO - 'HOME': '/home/cltbld', 21:02:34 INFO - 'LANG': 'en_US.UTF-8', 21:02:34 INFO - 'LANGUAGE': 'en_US:en', 21:02:34 INFO - 'LOGNAME': 'cltbld', 21:02:34 INFO - 'MAIL': '/var/mail/cltbld', 21:02:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:34 INFO - 'MOZ_NO_REMOTE': '1', 21:02:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:34 INFO - 'NO_EM_RESTART': '1', 21:02:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:34 INFO - 'PWD': '/builds/slave/test', 21:02:34 INFO - 'SHELL': '/bin/bash', 21:02:34 INFO - 'SHLVL': '1', 21:02:34 INFO - 'TERM': 'linux', 21:02:34 INFO - 'TMOUT': '86400', 21:02:34 INFO - 'USER': 'cltbld', 21:02:34 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006', 21:02:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:34 INFO - '_': '/tools/buildbot/bin/python'} 21:02:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:02:35 INFO - Cleaning up... 21:02:35 INFO - Return code: 0 21:02:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a5f1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a9ca80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1cfd310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1cfa400>, '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 0x1cfb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfb840>, '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': '8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:02:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:02:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:02:35 INFO - Using env: {'DISPLAY': ':0', 21:02:35 INFO - 'HOME': '/home/cltbld', 21:02:35 INFO - 'LANG': 'en_US.UTF-8', 21:02:35 INFO - 'LANGUAGE': 'en_US:en', 21:02:35 INFO - 'LOGNAME': 'cltbld', 21:02:35 INFO - 'MAIL': '/var/mail/cltbld', 21:02:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:35 INFO - 'MOZ_NO_REMOTE': '1', 21:02:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:35 INFO - 'NO_EM_RESTART': '1', 21:02:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:35 INFO - 'PWD': '/builds/slave/test', 21:02:35 INFO - 'SHELL': '/bin/bash', 21:02:35 INFO - 'SHLVL': '1', 21:02:35 INFO - 'TERM': 'linux', 21:02:35 INFO - 'TMOUT': '86400', 21:02:35 INFO - 'USER': 'cltbld', 21:02:35 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006', 21:02:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:35 INFO - '_': '/tools/buildbot/bin/python'} 21:02:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:02:35 INFO - Cleaning up... 21:02:35 INFO - Return code: 0 21:02:35 INFO - Running post-action listener: _resource_record_post_action 21:02:35 INFO - Running post-action listener: _start_resource_monitoring 21:02:35 INFO - Starting resource monitoring. 21:02:35 INFO - [mozharness: 2017-05-02 04:02:35.365680Z] Finished create-virtualenv step (success) 21:02:35 INFO - [mozharness: 2017-05-02 04:02:35.366190Z] Running install step. 21:02:35 INFO - Running pre-action listener: _resource_record_pre_action 21:02:35 INFO - Running main action method: install 21:02:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:02:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:02:35 INFO - Reading from file tmpfile_stdout 21:02:35 INFO - Detecting whether we're running mozinstall >=1.0... 21:02:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:02:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:02:35 INFO - Reading from file tmpfile_stdout 21:02:35 INFO - Output received: 21:02:35 INFO - Usage: mozinstall [options] installer 21:02:35 INFO - Options: 21:02:35 INFO - -h, --help show this help message and exit 21:02:35 INFO - -d DEST, --destination=DEST 21:02:35 INFO - Directory to install application into. [default: 21:02:35 INFO - "/builds/slave/test"] 21:02:35 INFO - --app=APP Application being installed. [default: firefox] 21:02:35 INFO - mkdir: /builds/slave/test/build/application 21:02:35 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'] 21:02:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:02:51 INFO - Reading from file tmpfile_stdout 21:02:51 INFO - Output received: 21:02:51 INFO - /builds/slave/test/build/application/firefox/firefox 21:02:51 INFO - Running post-action listener: _resource_record_post_action 21:02:51 INFO - [mozharness: 2017-05-02 04:02:51.842311Z] Finished install step (success) 21:02:51 INFO - [mozharness: 2017-05-02 04:02:51.842456Z] Running run-tests step. 21:02:51 INFO - Running pre-action listener: _resource_record_pre_action 21:02:51 INFO - Running main action method: run_tests 21:02:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:02:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:02:51 INFO - Python 2.7.3 21:02:51 INFO - Return code: 0 21:02:51 INFO - grabbing minidump binary from tooltool 21:02:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:51 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 0x1cfa400>, '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 0x1cfb3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cfb840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:02:51 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:02:51 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:02:51 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:02:51 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:02:51 INFO - Return code: 0 21:02:51 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:02:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:02:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:02:51 INFO - ENV: RUST_BACKTRACE is now 1 21:02:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:02:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:02:51 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/OtmnlyVqTSqBJbbsibWJ-Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:02:51 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/OtmnlyVqTSqBJbbsibWJ-Q/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-089 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:02:51 INFO - Using env: {'DISPLAY': ':0', 21:02:51 INFO - 'HOME': '/home/cltbld', 21:02:51 INFO - 'LANG': 'en_US.UTF-8', 21:02:51 INFO - 'LANGUAGE': 'en_US:en', 21:02:51 INFO - 'LOGNAME': 'cltbld', 21:02:51 INFO - 'MAIL': '/var/mail/cltbld', 21:02:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:02:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:02:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:51 INFO - 'MOZ_NO_REMOTE': '1', 21:02:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:02:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:02:51 INFO - 'NO_EM_RESTART': '1', 21:02:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:02:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:51 INFO - 'PWD': '/builds/slave/test', 21:02:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:02:51 INFO - 'RUST_BACKTRACE': '1', 21:02:51 INFO - 'SHELL': '/bin/bash', 21:02:51 INFO - 'SHLVL': '1', 21:02:51 INFO - 'TERM': 'linux', 21:02:51 INFO - 'TMOUT': '86400', 21:02:51 INFO - 'USER': 'cltbld', 21:02:51 INFO - 'XDG_SESSION_COOKIE': '8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006', 21:02:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:51 INFO - '_': '/tools/buildbot/bin/python'} 21:02:51 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/OtmnlyVqTSqBJbbsibWJ-Q/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-089', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:02:52 INFO - mozversion application_buildid: 20170502031525 21:02:52 INFO - mozversion application_changeset: 2e7c10a9b86e30691f67855f6c8f98d984508d7c 21:02:52 INFO - mozversion application_display_name: Nightly 21:02:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:02:52 INFO - mozversion application_name: Firefox 21:02:52 INFO - mozversion application_remotingname: firefox 21:02:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:02:52 INFO - mozversion application_vendor: Mozilla 21:02:52 INFO - mozversion application_version: 55.0a1 21:02:52 INFO - mozversion platform_buildid: 20170502031525 21:02:52 INFO - mozversion platform_changeset: 2e7c10a9b86e30691f67855f6c8f98d984508d7c 21:02:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:02:52 INFO - mozversion platform_version: 55.0a1 21:02:52 INFO - using testdate: 1493697772 21:02:52 INFO - actual date: 1493697772 21:02:52 INFO - starting webserver on 'localhost:39928' 21:02:52 INFO - SUITE-START | Running 2 tests 21:02:52 INFO - TEST-START | dromaeo_css 21:02:52 INFO - operating with platform_type : linux_ 21:02:52 INFO - Initialising browser for dromaeo_css test... 21:02:52 INFO - TEST-INFO | started process 16265 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDUEYK3/profile http://localhost:39928/getInfo.html) 21:02:56 INFO - PID 16265 | __metrics Screen width/height:1600/1200 21:02:56 INFO - PID 16265 | colorDepth:24 21:02:56 INFO - PID 16265 | Browser inner width/height: 1024/697 21:02:56 INFO - PID 16265 | __metrics 21:02:57 INFO - PID 16265 | 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" 21:02:57 INFO - PID 16265 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:02:58 INFO - TEST-INFO | 16265: exit 0 21:02:58 INFO - Browser initialized. 21:02:58 INFO - Running cycle 1/1 for dromaeo_css test... 21:02:58 INFO - TEST-INFO | started process 16360 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpDUEYK3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:03:10 INFO - PID 16360 | RSS: Main: 151564288 21:03:10 INFO - PID 16360 | 21:06:12 INFO - PID 16360 | Cycle 1(1): loaded http://localhost:39928/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39928/tests/dromaeo/cssquery-ext.html) 21:06:14 INFO - PID 16360 | RSS: Main: 311308288 21:06:14 INFO - PID 16360 | 21:08:00 INFO - PID 16360 | ************************* 21:08:00 INFO - PID 16360 | A coding exception was thrown and uncaught in a Task. 21:08:00 INFO - PID 16360 | 21:08:00 ERROR - PID 16360 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:08:00 INFO - PID 16360 | Full stack: 21:08:00 INFO - PID 16360 | ************************* 21:08:00 INFO - PID 16360 | ************************* 21:08:00 INFO - PID 16360 | A coding exception was thrown and uncaught in a Task. 21:08:00 INFO - PID 16360 | 21:08:00 ERROR - PID 16360 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:08:00 INFO - PID 16360 | Full stack: 21:08:00 INFO - PID 16360 | ************************* 21:08:00 INFO - PID 16360 | ************************* 21:08:00 INFO - PID 16360 | A coding exception was thrown and uncaught in a Task. 21:08:00 INFO - PID 16360 | 21:08:00 ERROR - PID 16360 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:08:00 INFO - PID 16360 | Full stack: 21:08:00 INFO - PID 16360 | ************************* 21:08:00 INFO - PID 16360 | ************************* 21:08:00 INFO - PID 16360 | A coding exception was thrown and uncaught in a Task. 21:08:00 INFO - PID 16360 | 21:08:00 ERROR - PID 16360 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:08:00 INFO - PID 16360 | Full stack: 21:08:00 INFO - PID 16360 | ************************* 21:09:16 INFO - PID 16360 | Cycle 1(1): loaded http://localhost:39928/tests/dromaeo/cssquery-ext.html (next: http://localhost:39928/tests/dromaeo/cssquery-jquery.html) 21:09:17 INFO - PID 16360 | RSS: Main: 224387072 21:09:17 INFO - PID 16360 | 21:12:18 INFO - PID 16360 | Cycle 1(1): loaded http://localhost:39928/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39928/tests/dromaeo/cssquery-mootools.html) 21:12:19 INFO - PID 16360 | RSS: Main: 199020544 21:12:19 INFO - PID 16360 | 21:15:21 INFO - PID 16360 | Cycle 1(1): loaded http://localhost:39928/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39928/tests/dromaeo/cssquery-prototype.html) 21:15:21 INFO - PID 16360 | RSS: Main: 189095936 21:15:21 INFO - PID 16360 | 21:18:24 INFO - PID 16360 | Cycle 1(1): loaded http://localhost:39928/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39928/tests/dromaeo/cssquery-yui.html) 21:18:25 INFO - PID 16360 | RSS: Main: 179601408 21:18:25 INFO - PID 16360 | 21:21:26 INFO - PID 16360 | Cycle 1(1): loaded http://localhost:39928/tests/dromaeo/cssquery-yui.html (next: http://localhost:39928/tests/dromaeo/cssquery-dojo.html) 21:21:27 INFO - PID 16360 | RSS: Main: 267616256 21:21:27 INFO - PID 16360 | 21:21:27 INFO - PID 16360 | __start_tp_report 21:21:27 INFO - PID 16360 | _x_x_mozilla_page_load 21:21:27 INFO - PID 16360 | _x_x_mozilla_page_load_details 21:21:27 INFO - PID 16360 | |i|pagename|runs| 21:21:27 INFO - PID 16360 | |0;dojo.html;3349.480830471277;3359.3281343731246;3380.019794259664;3393.762436629434;3415.7438192135596;5724.771009159628;5863.618864773786;5895.616784908983;5903.557233207505;5919.940800591993;5904.498117659993;5929.140274660172;5962.10568414738;5994;6013.368596297391;4848.175810112271;5073.441921388644;5192.039472697554;5217.634765566393;5231.346081739783;5246.317978662769;5271.551918086967;5296.496832800897;5318.840434786963;5326.280952071459;5095.770690318926;5175.249588809639;5209.791608335662;5267.499587539178;5281.445448227958;5181.96360727856;5214.947850521522;5221.164613661796;5244.318238628992;5305.814296499604;5175.353080864892;5222.033923724123;5239.738013099368;5241;5262;5768.423157684198;5827.504662103726;5841.766329346821;5844.707764611795;5911.76352945886;6227.3772622737815;6257.655828929407;6276.654783986879;6323.367663233686;6346.492280617539;6366.140571022899;6370.044493325991;6375.872482550323;6379.553431259814;6387.968060159669;5776;5887.8233652990475;5887.970560147215;5893.410658934158;5952.4047595241;6226.844328891723;6307.24313082433;6426.903596446057;6432.421082102634;6468.902966455413;6190.535709821781;6210.720517576629;6214.8135555933395;6225;6225;6250.593711408744;6290.937090629035;6292.653904035231;6315.084312774622;6319.24169099711;6120.051392034242;6179.876402471926;6267.934451143316;6271.655058971709;6283.05754136874;6275.278342990615;6350.777722779773;6355.269144048493;6356.968215158895;6360.4911607072245;4829.323894654751;4833.05755377698;4836.46798852126;4842.927356089662;4866.391701037371;4244.85143019999;4266.978665106654;4273.18809426208;4281.678874084456;4322.546132656089;5898.321693005273;5974.3726908674835;6018.097285407136;6046.727897244635;6049.395060494004;6322.589031712924;6348.365163483707;6397.392247736458;6399;6400.807975760735;5946.048632218911;5991.161237426763;5991.7902873399225;5997.100434934708;6005.849853753691;5452.40023597404;5536.972315138479;5545.251391062236;5604.523615492647;5608.4111168326735;6624.96687516569;6627.204735431779;6633.535652504278;6634.369734875179;6639.867202656016;6256.124142620128;6347;6404.967975160094;6429.38920802523;6431.742730290736;6502;6525.9021114684265;6549.410553050248;6565.901511477427;6618.437432818265;6253.405926436982;6306.842328941813;6316.652584107918;6318;6322.778702745381;6355.459785918249;6413.903791443039;6431.0031945048595;6437.969924812008;6439.388258115471;6082.482988945812;6142.109394137914;6150.2927163375;6201.131841542278;6215;6204.286507051746;6214.347493513297;6216.968915155395;6218;6219.222597175353;6100.572959892765;6139.723712432862;6166.660833654192;6176;6182.721777519932;6121.418465245794;6138.694953005908;6165.630062196283;6218.129461875251;6246.9062964054665;6105.338445949952;6107.144999699956;6112.625067133324;6117.705611546597;6134.631922084689 21:21:27 INFO - PID 16360 | |1;ext.html;738.7746737245138;803.5500119932838;817.5707753429447;1125.5216532973484;1149.195563105826;29120.271993200153;29817;36633.816830915806;37486.8125659372;37505;38451.23097538047;38872;38901.41647875284;38914.41628375577;38948.22103557934;5629.521490673298;7129.85740285194;7251.129864416251;7264.709411623555;7267.23694012129;5762.193292938992;7047.260037696045;7222.916562515612;7239.058922340115;7241.167265764452;7278.199398066208;7317.048783658117;7320.487565870391;7321.26787321269;7323.890141647879;5660.688662123582;7257.129144502667;7266.292421281048;7268.0914885639295;7308.524945878527;5768;6881.174259088892;7004.299570043006;7012.474064445136;7015.36861682451;35957.820210898775;36255.63744362549;36302;36320.63679363199;36338;3433.53647257622;3468.4623883298127;3478.3738926993133;3479.617242103392;3480.6171321154907;29111.708882911113;29174.708252917622;29186;29267.853660731562;29293;3730.3844865597143;3769.6418840210135;3786.8295926683363;3787.791671458069;3815.9427608585893;184179;184605;184607;184749;185078;47959;48297.758511207925;48353;48370.46998655207;48383.516164838606;49422.752886235336;49615.50384496181;49749.75125124351;49775.50224497781;49880.750596246784;15523.456679016406;15632.687346253011;15637.452689155825;15650.45223417175;15675.05949643025;11126;11404.372759498141;12804.10371274002;12805.807912881315;12807.103502754904;11878.821817672742;12003.579874704517;12844.614661560168;12940.352982350845;13105.606831795061;5390.838274851761;5513.42109078549;5552.167174923794;5594.244776955059;5613.270274864241;1068.273573969708;1094.6590426727196;1100.9229353945307;1105.9557617695364;1108.2353176308322;26464.251615838224;26553.46893062128;26629.46741065168;26789.732102679114;26819.597706034427;1166.597523854269;1172.9882701172878;1174.647605718281;1185.6620863053988;1198.8920997110301;13301;13794.724105517833;13986.510472133426;14007.789883151761;14063.367148478343;220297;220392.65484469492;220514;220795;220850;52179.21731174035;52194;52369.738151309764;52372.738136309075;52501.7374913123;1455.4469301665088;1467.156385078584;1488.5459934720013;1495.9850401495846;1507.2689745473438;24364.563543646203;25371.112011079524;25521.744782551938;25823.354416139748;25846.87076564605;38882.80558597189;38927.61072389353;38929.41605875857;38936.41595376128;38982.4152637705;202910;203088;203245;203490;204477;34201.657983420846;34330.82834585811;34352.48471272883;34414.13964650904;34437.65562344345;36143.27713445769;38424;41297.380539292535;41462.1707565841;41572.58427415687;30077;30845;30905.227369315948;31018.224544385666;31748.841255793574;30493.34526171614;31321;31525.211869703442;31858.20354491156;32043.519347209345;34590;34981.82509087438;35322.47016294809;35507.11232219215;36301.636983629825;28962;29229.561556576242;29496.262593435335;29568.260793480335;29972.70027299699;23401.648975265725;24127.276181714577;24670.383240419134;24684;24852.37869053288 21:21:27 INFO - PID 16360 | |2;jquery.html;370.71084554047854;440.65188501084145;451.92769156934895;461.20902651951906;465.2672041534584;19100.90449547752;19136.425907222787;19810.207591696315;20034.799652003476;20179.697304540445;20956.16175352984;21409.357719268446;22008.229711960084;22096.779032209673;22194.1122355106;5530.972345138279;5692.829215123553;5697.800576979786;5699.059655156915;5704.258446401962;5312.654677445973;5439.238506609078;5469.835904922858;5475.945240547603;5476.945230547703;5417.64785288957;5471.890562188773;5473.589480788937;5475.616706830523;5482.616216864821;5323.148296272597;5496.7526461309135;5537.556995440375;5538.086215774392;5539.778408863641;4936.6297527685565;5004.674696144739;5009.699418034929;5010.498950104997;5024.422191447957;23738.762612374;23833.285001449985;24059.759402405925;24184.637230441556;24534.754652453605;2202.7466841313294;2250.1224522436264;2250.313654335427;2251.887405629712;2254;16148.354065837353;16857.241424135944;16912.069836159008;16944.152792360455;17040.233189506376;2176.9020394082145;2210.7899749523767;2265.184533567914;2275.1354485295483;2281.555096756133;94513.52743236309;94887.52556237175;95006.52496737472;96326.51836740841;97902;11362.375069371099;11949.283043017273;12361.505539778487;12527;12722.809157862639;16768.916155419145;17051.91474042622;17801.643967120584;17825.46523604294;17861.48177404909;9148.405353652124;9244.537773111317;9479.336446448682;9563.234941204686;9563.474008929576;8747.081556436482;8813.647454101892;8822.206001459772;8976.640934362684;9045.457272563668;7760.095740156415;8023.959880200561;8077.717279895175;8140.308073813792;8245.299149572353;2096.3710886734225;2104.9579008419746;2122.458773012903;2159.838012149095;2170.0560256288563;1071.0842229893485;1092.2627226621998;1095.2606990281688;1100.8403781451646;1106.8339749037548;21610.675839862415;21707.348779536638;21731.23940662069;21910.780892190873;21966.45083872916;1121.545773961547;1122.3378206857992;1126.4987080748988;1129.203911242572;1154.2209008919115;11343.149263805248;11790.587329443428;11815.940920295516;11838.112141589416;11853.170278080452;468525;485249;486728;488601;491030;107337;110003.44998274957;110025.44987275012;110502.44748776365;111155;1218.8842060004285;1219.646302572262;1246.9064820138526;1252.536561472243;1256.327864592457;17622.64754704873;17810.419329013846;18178.818211817714;18270.086495674896;18445;49307.77952379902;49665.751671241414;49695.751521242164;49717.254241185685;50657.49342506675;61513;62195.06707399302;63268.68365658142;64742.676286620146;66023;9170.495622740547;9248.815023699623;9541.618335266512;9691.806163876823;9756.121949024622;14899.404023838924;15888;15898.761518577;16183.271752770917;16896.915515422344;13183.340832958505;13232.536861209812;13802.17186968785;13852.307384630527;13963.441462341392;12417.503299867903;12512.937435312766;12535.373231338579;12606.369681516071;13178.27519486399;13442.327883605585;13675.452981880613;13735.862641373458;14098.78851817203;14325.140491570539;9506.429614223169;9891.35706179096;9932.404055756677;9940.751481213027;10264.948675256876;12851.357432128169;13034.348282586023;13051.347432628141;13360.799588005993;14270.571882843531 21:21:27 INFO - PID 16360 | |3;mootools.html;1330.3747238797766;1388.3058470764618;1390.7079513302206;1406.416337220053;1407.5566196648062;10854.891451085487;11395.202335836495;11395.943020284907;11396.886031139686;11410.885891141086;11111.72220694483;11708.473118709657;11753.941230293836;11765.70585735357;11768.293902365864;2313.5257272259146;2356.9175078872245;2360.079568968104;2363.5509253241917;2369.3839601703507;1953.3749200255925;2269.80706639935;2326.5928462519078;2333.4982978659586;2338.2751347082376;2022.888741119238;2276.271593090212;2369.597168481362;2372.4306166519996;2372.7983121434613;2251.268337790225;2298.977010229901;2306.1697788796105;2306.988465057664;2311.884405779713;2269.8751568663715;2272.3523795718143;2311.6879221305076;2327.650852372141;2333.0551126793675;11417.942910285396;11531.654050378418;11547.364894930775;11552.480138393792;11583.247088939192;6387.776427825051;6601.141851559315;6602.3067577904585;6604.14146160996;6604.306547812506;3712.517372741553;3960.4851369321805;4000.879973600797;4033.69747268956;4035.7578545287083;1274.3628185907046;1321.0950498908278;1331.3343328335832;1383.8546952569936;1413.696055348095;17434.651306973916;17570;17582.472525824247;17591.472255832345;17593.12034398288;5020.071286811952;5090.440051594322;5199.896002079937;5378.865528361822;5453.918191227135;12592.87407125917;12626.116171867881;12627.93686031564;12634.494620215271;12640.178388404724;6369.076483909807;6416;6421.133147025185;6425.036244563259;6439.613623182624;5885.646861188342;6029.668368239789;6036.185115009417;6066.363031881677;6165.1985241919165;4031.5913357260656;4140.0891803803115;4141.399497072907;4170.16596680665;4212.894677633022;1037.2376303416982;1065.888081751405;1177.5584155941522;1185.146694380045;1193.2601786892183;824.744329257932;858.759547326737;865.0527672198932;880.8502554565739;891.7592250092439;6684.598924064571;6768.796936091925;6786.524943254023;6788;7075.787726368218;623.8970569855923;627.5763859394981;627.7740013595102;639.961602303854;747.2602123897302;4366.19225443294;4451.310046942729;4455.665825063068;4461.888452788641;4480.4623445186135;14687.77968330476;15492.612684682748;15549.689006219813;15566.377344906303;15576.688466230611;14765.187914664582;15423.768643470132;15442.305096270695;15468.149251791034;15475.767863482057;9264.44413335202;9438.498797818584;9456.385334953206;9459.195968342769;9467.573959171854;6924.203716572457;7083.964580177066;7094.432445404252;7115.395191408581;7267.454940879349;13321.86678133245;13443;13513.729725405241;13758.449662013807;13773.793393098911;13866.098703584235;13909.513167039106;14119.505817296345;14218;14283.143011419348;8879.644814207359;9151.86272205904;9219.44683319003;9225.58484868169;9233.815323693623;10724.839127412939;10799.40603266828;10812.621558245424;10824.458777060958;10855.728606784893;8896.2882969361;9161.541922903694;9164.770880728036;9194.95402522983;9336.06639336061;8888.288936885163;8898.688545900863;8920.286377089687;9050.683226087318;9087.591058402255;7935.920640793518;8024.317932975762;8051.315638170821;8058.879116813136;8094.51432914027;5951.672658003851;5963.552733544915;5966.2840459143445;6070.939290607214;6196.81409557714;6002.159697642246;6013.9699301503215;6027.30685971119;6033.637981720935;6264.060390941395 21:21:27 INFO - PID 16360 | |4;prototype.html;417.7556129664146;417.80780840813225;430.7544699521273;432.35578987308907;445.0853496065584;5611.887762244753;5753.482186603205;5774;5893.292804863417;5895.204147440094;5611.551075913927;5771.249737534125;5772.711364431782;5791.031049443189;5791.797287094942;4569.565891240327;4573.977130114345;4589.311603259504;4591.885202869938;4593;4535.183666939949;4567.566081222279;4608.5161058088925;4611.6310695144475;4624.098300831322;4561.726296422209;4563.657725670588;4568.109218702354;4573.7027093239;4584.15193189261;4571.200039993005;4575.428071491064;4576.427946506687;4580.977095114503;4590.97704511477;4072.859599312197;4114.7119701620895;4157.625813676754;4161.167766446722;4165.354370072613;5631.831045068655;5637.577181711388;5662.773489060474;5675.120356344773;5712.914306285409;5361.115415956362;5411.810586629488;5418.4039755626845;5440.265564148868;5456.48163424474;5995.940040599626;6170.907436388457;6184.19605451293;6197.597156184834;6212.316645169073;4644.442666879962;4662.393888794469;4670.112678591091;4677.906441871143;4697.365855609483;6151.415615516519;6283.968580157116;6297.496200304011;6318.33657465964;6356.237251529846;4816.8073277069225;4842.080004799077;4864.513548645107;4871.610271178297;4882.218844984785;4877.219644856806;4884.340614017062;4895.461499235082;4899.5590396863745;4903.509649035139;5257.553107985787;5348.786048558092;5406.432324605938;5410.48600382963;5424.484673955968;5890.823275301748;6153.292371377349;6181.629102253879;6201.81394558164;6206.937930620727;1617.9838201618068;1653.7106006448823;1689.9662006759795;1692.1539230384808;1695.364238410596;1128.227164392394;1168.1530890104775;1177.8292147638545;1179.3808250668467;1191.5293459083614;5955.910661340084;5961.612495187799;5965.13505541694;5974.581779275409;5997.160397544348;6334.954732469183;6354.110424540568;6355.9830427132365;6362.331955144736;6363.7772677956045;5768.653880767168;5902.085176797603;5969.970150149308;5970.432808883149;5995.100734889714;3334.899953001414;3336.9165770855925;3364.4616861302075;3366.848491817874;3375.814330211862;6508.544401891822;6661.233958094881;6691.7323307068145;6700.966495167493;6713.825080610874;6512.413882750575;6518.152640156749;6526.836829079216;6549.705263263165;6555.147830781968;6429.421352078335;6507.284198738135;6586.6198977679305;6597.109390232257;6621.33786621334;6235.3452887446165;6244.500439964701;6261.373862613702;6308.211473565804;6309.558330916791;6124.448799608057;6195.81412557624;6219.782307619212;6235.3452887446165;6263.404976527405;6564.146660934048;6619.702113405005;6626.701798418986;6650.434713049445;6655.134832471941;4838.274258861199;4843.176659967743;4847.660663753644;4850.6119510438375;4860.076585448754;6062.696865156637;6149.200603921461;6193.721282542207;6290.2766181889665;6356.9046464304;6014.969925150346;6145.834895028975;6160.938390616216;6174.228221472316;6186.1339412483185;5952.476118150324;6159.1377207190135;6159.23009623797;6174.289956654862;6179.567430280017;6099.84750381244;6142.846428839315;6148.231471066117;6150.570524642651;6155.1382806406245;6149.754009839557;6150.876982460415;6155.137441421227;6157;6191.504679625529;5828.883422331614;6008.459238668541;6018.849528761816;6055.364186760503;6099.634021958696 21:21:27 INFO - PID 16360 | |5;yui.html;753.6533194730424;865.6494119881448;877.7279043496517;878.4026861734018;880.8106257154712;13450.260235687045;16486.67026659466;17396.848166078926;17639.73540396895;17740.645187096252;16426;16985;17055.232514536845;17159.91420042901;17173;998.2100030415007;1028.7530992561806;1029.1406675426028;1029.5675816157195;1030.4435604773414;726.0996364508024;742.2132539508111;1037.8235699930992;1038.2732087538716;1039.6517166749147;1023.5445226874044;1053.346924906559;1054.5676272728183;1054.662507997441;1055.5250137438145;1042.593388578455;1047.9790404191874;1048.5596049659123;1049.1134990932649;1050.7320633238514;777.0869228656363;777.1179711027968;777.1179711027968;777.6811507282043;781.3631890009624;15947.122908240042;16268.674626507403;16348.100854453;16485.58786030347;16512.669746605;17340.826591734047;17446.127693615268;17743.73384399235;17825.46523604294;17956.281748730034;13176.538821141214;13227.272500012496;13315.533956311483;13451.192928424325;13714.51999180024;3349.330133973215;3387.3902697514436;3389.254364039907;3389.3390788796196;3390.7965522068753;87549.12450875473;90796;91699;91762;92129.99999999933;12124.939375303067;14190.858091418953;14642.85357146415;14710.852891470948;14765.483208087666;20088.89955550213;22075.448113796963;26823.865880670473;27565.724342756715;27764.305892352448;8316.958415207886;8556.101609331055;8570.142985701505;8575.914240857637;8587.871181932276;4185.895352616209;4188.958110418856;4224.239636865333;4250.468691413574;4273.487181538236;4547.272436410225;4637.072585482917;4639.188142075191;4643.628509719214;4644.16405047088;716.7276434954788;745.2845268542152;747.8915557244169;748.8165399477163;751.6617522115071;644.5230529408298;650.6974256970436;661.5931202310544;665.747016133866;675.7499725101744;11010.375642230283;11050.668479945614;11582.84171582835;11634.360110193851;11894.107941904393;639.2488825629866;651.1730102769457;660.9966950165218;671.2750229751856;675.2369822100994;4799.136155492045;4932.926006109911;5136;5162.432132465426;5195.272661827347;82676.17323826805;84522;85503;86464.5676771612;88065;70313.64843175751;72079.27920720726;74612;75910.62044689742;77365;59103.70448147818;60347.39652603418;60488.395116049156;62163.689181553804;64654.67672661607;12098.274103553815;13265.801012985006;13289.401976910869;13320.733585328433;13354.532591359255;33145.668543314256;33374.33251334911;34297;34306;34321.65678343185;40161;40602.79698601488;40660.39009414802;41144.588554114074;41835.163296733284;16474;16601;16696.49910502687;16907.577310567332;16928;16681.165941702624;16744.246508906886;16745.390676166142;16848.15759212059;16853;17395.652086958442;17527.561810954317;17588.472345829647;17661.381851635644;18081.819181808012;17383.652326953135;17628;17767.555811104827;17804.46586602404;17851.196696148443;16766.32934682648;16772.412965546147;16881.577960551083;16928.238229279465;17096.145192740063;10209.897901021192;10334.121599663811;10369.274150809371;10489.895101048893;10608.946955265174;11847.881521184678;12118.091143164474;12180.45187966526;12217.51129954792;12290.446929887998 21:21:27 INFO - PID 16360 | __end_tp_report 21:21:27 INFO - PID 16360 | __start_cc_report 21:21:27 INFO - PID 16360 | _x_x_mozilla_cycle_collect,1533 21:21:27 INFO - PID 16360 | __end_cc_report 21:21:27 INFO - PID 16360 | __startTimestamp1493698887182__endTimestamp 21:21:27 INFO - PID 16360 | 21:21:27 INFO - PID 16360 | ------- Summary: start ------- 21:21:27 INFO - PID 16360 | Number of tests: 6 21:21:27 INFO - PID 16360 | 21:21:27 INFO - PID 16360 | [#0] dojo.html Cycles:165 Average:5855.19 Median:6121.42 stddev:697.90 (11.4%) stddev-sans-first:671.79 21:21:27 INFO - PID 16360 | Values: 3349.5 3359.3 3380.0 3393.8 3415.7 5724.8 5863.6 5895.6 5903.6 5919.9 5904.5 5929.1 5962.1 5994.0 6013.4 4848.2 5073.4 5192.0 5217.6 5231.3 5246.3 5271.6 5296.5 5318.8 5326.3 5095.8 5175.2 5209.8 5267.5 5281.4 5182.0 5214.9 5221.2 5244.3 5305.8 5175.4 5222.0 5239.7 5241.0 5262.0 5768.4 5827.5 5841.8 5844.7 5911.8 6227.4 6257.7 6276.7 6323.4 6346.5 6366.1 6370.0 6375.9 6379.6 6388.0 5776.0 5887.8 5888.0 5893.4 5952.4 6226.8 6307.2 6426.9 6432.4 6468.9 6190.5 6210.7 6214.8 6225.0 6225.0 6250.6 6290.9 6292.7 6315.1 6319.2 6120.1 6179.9 6267.9 6271.7 6283.1 6275.3 6350.8 6355.3 6357.0 6360.5 4829.3 4833.1 4836.5 4842.9 4866.4 4244.9 4267.0 4273.2 4281.7 4322.5 5898.3 5974.4 6018.1 6046.7 6049.4 6322.6 6348.4 6397.4 6399.0 6400.8 5946.0 5991.2 5991.8 5997.1 6005.8 5452.4 5537.0 5545.3 5604.5 5608.4 6625.0 6627.2 6633.5 6634.4 6639.9 6256.1 6347.0 6405.0 6429.4 6431.7 6502.0 6525.9 6549.4 6565.9 6618.4 6253.4 6306.8 6316.7 6318.0 6322.8 6355.5 6413.9 6431.0 6438.0 6439.4 6082.5 6142.1 6150.3 6201.1 6215.0 6204.3 6214.3 6217.0 6218.0 6219.2 6100.6 6139.7 6166.7 6176.0 6182.7 6121.4 6138.7 6165.6 6218.1 6246.9 6105.3 6107.1 6112.6 6117.7 6134.6 21:21:27 INFO - PID 16360 | 21:21:27 INFO - PID 16360 | [#1] ext.html Cycles:180 Average:36677.30 Median:18882.18 stddev:52702.14 (279.1%) stddev-sans-first:52780.90 21:21:27 INFO - PID 16360 | Values: 738.8 803.6 817.6 1125.5 1149.2 29120.3 29817.0 36633.8 37486.8 37505.0 38451.2 38872.0 38901.4 38914.4 38948.2 5629.5 7129.9 7251.1 7264.7 7267.2 5762.2 7047.3 7222.9 7239.1 7241.2 7278.2 7317.0 7320.5 7321.3 7323.9 5660.7 7257.1 7266.3 7268.1 7308.5 5768.0 6881.2 7004.3 7012.5 7015.4 35957.8 36255.6 36302.0 36320.6 36338.0 3433.5 3468.5 3478.4 3479.6 3480.6 29111.7 29174.7 29186.0 29267.9 29293.0 3730.4 3769.6 3786.8 3787.8 3815.9 184179.0 184605.0 184607.0 184749.0 185078.0 47959.0 48297.8 48353.0 48370.5 48383.5 49422.8 49615.5 49749.8 49775.5 49880.8 15523.5 15632.7 15637.5 15650.5 15675.1 11126.0 11404.4 12804.1 12805.8 12807.1 11878.8 12003.6 12844.6 12940.4 13105.6 5390.8 5513.4 5552.2 5594.2 5613.3 1068.3 1094.7 1100.9 1106.0 1108.2 26464.3 26553.5 26629.5 26789.7 26819.6 1166.6 1173.0 1174.6 1185.7 1198.9 13301.0 13794.7 13986.5 14007.8 14063.4 220297.0 220392.7 220514.0 220795.0 220850.0 52179.2 52194.0 52369.7 52372.7 52501.7 1455.4 1467.2 1488.5 1496.0 1507.3 24364.6 25371.1 25521.7 25823.4 25846.9 38882.8 38927.6 38929.4 38936.4 38982.4 202910.0 203088.0 203245.0 203490.0 204477.0 34201.7 34330.8 34352.5 34414.1 34437.7 36143.3 38424.0 41297.4 41462.2 41572.6 30077.0 30845.0 30905.2 31018.2 31748.8 30493.3 31321.0 31525.2 31858.2 32043.5 34590.0 34981.8 35322.5 35507.1 36301.6 28962.0 29229.6 29496.3 29568.3 29972.7 23401.6 24127.3 24670.4 24684.0 24852.4 21:21:27 INFO - PID 16360 | 21:21:27 INFO - PID 16360 | [#2] jquery.html Cycles:180 Average:31084.43 Median:12149.76 stddev:80496.92 (662.5%) stddev-sans-first:80689.71 21:21:27 INFO - PID 16360 | Values: 370.7 440.7 451.9 461.2 465.3 19100.9 19136.4 19810.2 20034.8 20179.7 20956.2 21409.4 22008.2 22096.8 22194.1 5531.0 5692.8 5697.8 5699.1 5704.3 5312.7 5439.2 5469.8 5475.9 5476.9 5417.6 5471.9 5473.6 5475.6 5482.6 5323.1 5496.8 5537.6 5538.1 5539.8 4936.6 5004.7 5009.7 5010.5 5024.4 23738.8 23833.3 24059.8 24184.6 24534.8 2202.7 2250.1 2250.3 2251.9 2254.0 16148.4 16857.2 16912.1 16944.2 17040.2 2176.9 2210.8 2265.2 2275.1 2281.6 94513.5 94887.5 95006.5 96326.5 97902.0 11362.4 11949.3 12361.5 12527.0 12722.8 16768.9 17051.9 17801.6 17825.5 17861.5 9148.4 9244.5 9479.3 9563.2 9563.5 8747.1 8813.6 8822.2 8976.6 9045.5 7760.1 8024.0 8077.7 8140.3 8245.3 2096.4 2105.0 2122.5 2159.8 2170.1 1071.1 1092.3 1095.3 1100.8 1106.8 21610.7 21707.3 21731.2 21910.8 21966.5 1121.5 1122.3 1126.5 1129.2 1154.2 11343.1 11790.6 11815.9 11838.1 11853.2 468525.0 485249.0 486728.0 488601.0 491030.0 107337.0 110003.4 110025.4 110502.4 111155.0 1218.9 1219.6 1246.9 1252.5 1256.3 17622.6 17810.4 18178.8 18270.1 18445.0 49307.8 49665.8 49695.8 49717.3 50657.5 61513.0 62195.1 63268.7 64742.7 66023.0 9170.5 9248.8 9541.6 9691.8 9756.1 14899.4 15888.0 15898.8 16183.3 16896.9 13183.3 13232.5 13802.2 13852.3 13963.4 12417.5 12512.9 12535.4 12606.4 13178.3 13442.3 13675.5 13735.9 14098.8 14325.1 9506.4 9891.4 9932.4 9940.8 10264.9 12851.4 13034.3 13051.3 13360.8 14270.6 21:21:27 INFO - PID 16360 | 21:21:27 INFO - PID 16360 | [#3] mootools.html Cycles:180 Average:7169.64 Median:3836.50 stddev:4688.01 (122.2%) stddev-sans-first:4680.62 21:21:27 INFO - PID 16360 | Values: 1330.4 1388.3 1390.7 1406.4 1407.6 10854.9 11395.2 11395.9 11396.9 11410.9 11111.7 11708.5 11753.9 11765.7 11768.3 2313.5 2356.9 2360.1 2363.6 2369.4 1953.4 2269.8 2326.6 2333.5 2338.3 2022.9 2276.3 2369.6 2372.4 2372.8 2251.3 2299.0 2306.2 2307.0 2311.9 2269.9 2272.4 2311.7 2327.7 2333.1 11417.9 11531.7 11547.4 11552.5 11583.2 6387.8 6601.1 6602.3 6604.1 6604.3 3712.5 3960.5 4000.9 4033.7 4035.8 1274.4 1321.1 1331.3 1383.9 1413.7 17434.7 17570.0 17582.5 17591.5 17593.1 5020.1 5090.4 5199.9 5378.9 5453.9 12592.9 12626.1 12627.9 12634.5 12640.2 6369.1 6416.0 6421.1 6425.0 6439.6 5885.6 6029.7 6036.2 6066.4 6165.2 4031.6 4140.1 4141.4 4170.2 4212.9 1037.2 1065.9 1177.6 1185.1 1193.3 824.7 858.8 865.1 880.9 891.8 6684.6 6768.8 6786.5 6788.0 7075.8 623.9 627.6 627.8 640.0 747.3 4366.2 4451.3 4455.7 4461.9 4480.5 14687.8 15492.6 15549.7 15566.4 15576.7 14765.2 15423.8 15442.3 15468.1 15475.8 9264.4 9438.5 9456.4 9459.2 9467.6 6924.2 7084.0 7094.4 7115.4 7267.5 13321.9 13443.0 13513.7 13758.4 13773.8 13866.1 13909.5 14119.5 14218.0 14283.1 8879.6 9151.9 9219.4 9225.6 9233.8 10724.8 10799.4 10812.6 10824.5 10855.7 8896.3 9161.5 9164.8 9195.0 9336.1 8888.3 8898.7 8920.3 9050.7 9087.6 7935.9 8024.3 8051.3 8058.9 8094.5 5951.7 5963.6 5966.3 6070.9 6196.8 6002.2 6014.0 6027.3 6033.6 6264.1 21:21:27 INFO - PID 16360 | 21:21:27 INFO - PID 16360 | [#4] prototype.html Cycles:180 Average:5243.07 Median:5892.06 stddev:1491.36 (25.3%) stddev-sans-first:1450.90 21:21:27 INFO - PID 16360 | Values: 417.8 417.8 430.8 432.4 445.1 5611.9 5753.5 5774.0 5893.3 5895.2 5611.6 5771.2 5772.7 5791.0 5791.8 4569.6 4574.0 4589.3 4591.9 4593.0 4535.2 4567.6 4608.5 4611.6 4624.1 4561.7 4563.7 4568.1 4573.7 4584.2 4571.2 4575.4 4576.4 4581.0 4591.0 4072.9 4114.7 4157.6 4161.2 4165.4 5631.8 5637.6 5662.8 5675.1 5712.9 5361.1 5411.8 5418.4 5440.3 5456.5 5995.9 6170.9 6184.2 6197.6 6212.3 4644.4 4662.4 4670.1 4677.9 4697.4 6151.4 6284.0 6297.5 6318.3 6356.2 4816.8 4842.1 4864.5 4871.6 4882.2 4877.2 4884.3 4895.5 4899.6 4903.5 5257.6 5348.8 5406.4 5410.5 5424.5 5890.8 6153.3 6181.6 6201.8 6206.9 1618.0 1653.7 1690.0 1692.2 1695.4 1128.2 1168.2 1177.8 1179.4 1191.5 5955.9 5961.6 5965.1 5974.6 5997.2 6335.0 6354.1 6356.0 6362.3 6363.8 5768.7 5902.1 5970.0 5970.4 5995.1 3334.9 3336.9 3364.5 3366.8 3375.8 6508.5 6661.2 6691.7 6701.0 6713.8 6512.4 6518.2 6526.8 6549.7 6555.1 6429.4 6507.3 6586.6 6597.1 6621.3 6235.3 6244.5 6261.4 6308.2 6309.6 6124.4 6195.8 6219.8 6235.3 6263.4 6564.1 6619.7 6626.7 6650.4 6655.1 4838.3 4843.2 4847.7 4850.6 4860.1 6062.7 6149.2 6193.7 6290.3 6356.9 6015.0 6145.8 6160.9 6174.2 6186.1 5952.5 6159.1 6159.2 6174.3 6179.6 6099.8 6142.8 6148.2 6150.6 6155.1 6149.8 6150.9 6155.1 6157.0 6191.5 5828.9 6008.5 6018.8 6055.4 6099.6 21:21:27 INFO - PID 16360 | 21:21:27 INFO - PID 16360 | [#5] yui.html Cycles:180 Average:18680.38 Median:18019.05 stddev:23277.65 (129.2%) stddev-sans-first:23304.02 21:21:27 INFO - PID 16360 | Values: 753.7 865.6 877.7 878.4 880.8 13450.3 16486.7 17396.8 17639.7 17740.6 16426.0 16985.0 17055.2 17159.9 17173.0 998.2 1028.8 1029.1 1029.6 1030.4 726.1 742.2 1037.8 1038.3 1039.7 1023.5 1053.3 1054.6 1054.7 1055.5 1042.6 1048.0 1048.6 1049.1 1050.7 777.1 777.1 777.1 777.7 781.4 15947.1 16268.7 16348.1 16485.6 16512.7 17340.8 17446.1 17743.7 17825.5 17956.3 13176.5 13227.3 13315.5 13451.2 13714.5 3349.3 3387.4 3389.3 3389.3 3390.8 87549.1 90796.0 91699.0 91762.0 92130.0 12124.9 14190.9 14642.9 14710.9 14765.5 20088.9 22075.4 26823.9 27565.7 27764.3 8317.0 8556.1 8570.1 8575.9 8587.9 4185.9 4189.0 4224.2 4250.5 4273.5 4547.3 4637.1 4639.2 4643.6 4644.2 716.7 745.3 747.9 748.8 751.7 644.5 650.7 661.6 665.7 675.7 11010.4 11050.7 11582.8 11634.4 11894.1 639.2 651.2 661.0 671.3 675.2 4799.1 4932.9 5136.0 5162.4 5195.3 82676.2 84522.0 85503.0 86464.6 88065.0 70313.6 72079.3 74612.0 75910.6 77365.0 59103.7 60347.4 60488.4 62163.7 64654.7 12098.3 13265.8 13289.4 13320.7 13354.5 33145.7 33374.3 34297.0 34306.0 34321.7 40161.0 40602.8 40660.4 41144.6 41835.2 16474.0 16601.0 16696.5 16907.6 16928.0 16681.2 16744.2 16745.4 16848.2 16853.0 17395.7 17527.6 17588.5 17661.4 18081.8 17383.7 17628.0 17767.6 17804.5 17851.2 16766.3 16772.4 16881.6 16928.2 17096.1 10209.9 10334.1 10369.3 10489.9 10608.9 11847.9 12118.1 12180.5 12217.5 12290.4 21:21:27 INFO - PID 16360 | -------- Summary: end -------- 21:21:27 INFO - PID 16360 | 21:21:28 INFO - TEST-INFO | 16360: exit 0 21:21:28 INFO - TEST-OK | dromaeo_css | took 1115926ms 21:21:28 INFO - TEST-START | kraken 21:21:28 INFO - operating with platform_type : linux_ 21:21:28 INFO - Initialising browser for kraken test... 21:21:28 INFO - TEST-INFO | started process 16695 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq48P1M/profile http://localhost:39928/getInfo.html) 21:21:32 INFO - PID 16695 | __metrics Screen width/height:1600/1200 21:21:32 INFO - PID 16695 | colorDepth:24 21:21:32 INFO - PID 16695 | Browser inner width/height: 1024/697 21:21:32 INFO - PID 16695 | __metrics 21:21:33 INFO - PID 16695 | 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" 21:21:33 INFO - PID 16695 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:21:34 INFO - TEST-INFO | 16695: exit 0 21:21:34 INFO - Browser initialized. 21:21:34 INFO - Running cycle 1/1 for kraken test... 21:21:34 INFO - TEST-INFO | started process 16789 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq48P1M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:21:46 INFO - PID 16789 | RSS: Main: 150974464 21:21:46 INFO - PID 16789 | 21:21:48 INFO - PID 16789 | Cycle 1(1): loaded http://localhost:39928/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39928/tests/kraken/driver.html?testName=audio-beat-detection) 21:21:49 INFO - PID 16789 | RSS: Main: 223682560 21:21:49 INFO - PID 16789 | 21:21:52 INFO - PID 16789 | Cycle 1(1): loaded http://localhost:39928/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39928/tests/kraken/driver.html?testName=audio-dft) 21:21:52 INFO - PID 16789 | RSS: Main: 183775232 21:21:52 INFO - PID 16789 | 21:21:55 INFO - PID 16789 | Cycle 1(1): loaded http://localhost:39928/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39928/tests/kraken/driver.html?testName=audio-fft) 21:21:56 INFO - PID 16789 | RSS: Main: 264335360 21:21:56 INFO - PID 16789 | 21:21:58 INFO - PID 16789 | Cycle 1(1): loaded http://localhost:39928/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39928/tests/kraken/driver.html?testName=audio-oscillator) 21:21:58 INFO - PID 16789 | RSS: Main: 175820800 21:21:58 INFO - PID 16789 | 21:22:00 INFO - PID 16789 | Cycle 1(1): loaded http://localhost:39928/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39928/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:22:01 INFO - PID 16789 | RSS: Main: 178675712 21:22:01 INFO - PID 16789 | 21:22:04 INFO - PID 16789 | Cycle 1(1): loaded http://localhost:39928/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39928/tests/kraken/driver.html?testName=imaging-darkroom) 21:22:04 INFO - PID 16789 | RSS: Main: 239431680 21:22:04 INFO - PID 16789 | 21:22:08 INFO - PID 16789 | Cycle 1(1): loaded http://localhost:39928/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39928/tests/kraken/driver.html?testName=imaging-desaturate) 21:22:08 INFO - PID 16789 | RSS: Main: 256389120 21:22:08 INFO - PID 16789 | 21:22:11 INFO - PID 16789 | Cycle 1(1): loaded http://localhost:39928/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39928/tests/kraken/driver.html?testName=json-parse-financial) 21:22:12 INFO - PID 16789 | RSS: Main: 268677120 21:22:12 INFO - PID 16789 | 21:22:13 INFO - PID 16789 | Cycle 1(1): loaded http://localhost:39928/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39928/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:22:14 INFO - PID 16789 | RSS: Main: 203657216 21:22:14 INFO - PID 16789 | 21:22:15 INFO - PID 16789 | Cycle 1(1): loaded http://localhost:39928/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39928/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:22:16 INFO - PID 16789 | RSS: Main: 208068608 21:22:16 INFO - PID 16789 | 21:22:18 INFO - PID 16789 | Cycle 1(1): loaded http://localhost:39928/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39928/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:22:19 INFO - PID 16789 | RSS: Main: 217460736 21:22:19 INFO - PID 16789 | 21:22:21 INFO - PID 16789 | Cycle 1(1): loaded http://localhost:39928/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39928/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:22:22 INFO - PID 16789 | RSS: Main: 226209792 21:22:22 INFO - PID 16789 | 21:22:25 INFO - PID 16789 | Cycle 1(1): loaded http://localhost:39928/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39928/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:22:25 INFO - PID 16789 | RSS: Main: 221560832 21:22:25 INFO - PID 16789 | 21:22:27 INFO - PID 16789 | Cycle 1(1): loaded http://localhost:39928/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39928/tests/kraken/driver.html?testName=ai-astar) 21:22:27 INFO - PID 16789 | RSS: Main: 271704064 21:22:27 INFO - PID 16789 | 21:22:27 INFO - PID 16789 | __start_tp_report 21:22:27 INFO - PID 16789 | _x_x_mozilla_page_load 21:22:27 INFO - PID 16789 | _x_x_mozilla_page_load_details 21:22:27 INFO - PID 16789 | |i|pagename|runs| 21:22:27 INFO - PID 16789 | |0;ai-astar;103;118;109;108;109;109;109;109;110;109 21:22:27 INFO - PID 16789 | |1;audio-beat-detection;143;117;123;158;118;117;119;118;138;117 21:22:27 INFO - PID 16789 | |2;audio-dft;162;160;160;162;161;160;160;161;163;162 21:22:27 INFO - PID 16789 | |3;audio-fft;75;73;73;111;81;73;74;74;102;75 21:22:27 INFO - PID 16789 | |4;audio-oscillator;83;82;99;82;81;81;94;81;81;111 21:22:27 INFO - PID 16789 | |5;imaging-gaussian-blur;114;113;113;113;113;113;113;113;113;112 21:22:27 INFO - PID 16789 | |6;imaging-darkroom;147;147;146;147;146;147;148;145;146;147 21:22:27 INFO - PID 16789 | |7;imaging-desaturate;93;95;93;93;94;94;93;93;93;94 21:22:27 INFO - PID 16789 | |8;json-parse-financial;49;46;45;45;46;46;48;46;47;47 21:22:27 INFO - PID 16789 | |9;json-stringify-tinderbox;56;54;54;54;53;54;53;54;54;54 21:22:27 INFO - PID 16789 | |10;stanford-crypto-aes;82;82;81;90;82;82;81;81;82;81 21:22:27 INFO - PID 16789 | |11;stanford-crypto-ccm;135;124;127;127;125;121;131;123;169;120 21:22:27 INFO - PID 16789 | |12;stanford-crypto-pbkdf2;181;181;185;179;181;180;183;186;182;178 21:22:27 INFO - PID 16789 | |13;stanford-crypto-sha256-iterative;66;68;65;64;66;64;63;64;62;64 21:22:27 INFO - PID 16789 | __end_tp_report 21:22:27 INFO - PID 16789 | __start_cc_report 21:22:27 INFO - PID 16789 | _x_x_mozilla_cycle_collect,1661 21:22:27 INFO - PID 16789 | __end_cc_report 21:22:27 INFO - PID 16789 | __startTimestamp1493698947815__endTimestamp 21:22:27 INFO - PID 16789 | 21:22:27 INFO - PID 16789 | ------- Summary: start ------- 21:22:27 INFO - PID 16789 | Number of tests: 14 21:22:27 INFO - PID 16789 | 21:22:27 INFO - PID 16789 | [#0] ai-astar Cycles:10 Average:109.30 Median:109.00 stddev:3.62 (3.3%) stddev-sans-first:3.04 21:22:27 INFO - PID 16789 | Values: 103.0 118.0 109.0 108.0 109.0 109.0 109.0 109.0 110.0 109.0 21:22:27 INFO - PID 16789 | 21:22:27 INFO - PID 16789 | [#1] audio-beat-detection Cycles:10 Average:126.80 Median:121.00 stddev:14.45 (11.9%) stddev-sans-first:14.09 21:22:27 INFO - PID 16789 | Values: 143.0 117.0 123.0 158.0 118.0 117.0 119.0 118.0 138.0 117.0 21:22:27 INFO - PID 16789 | 21:22:27 INFO - PID 16789 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:1.10 (0.7%) stddev-sans-first:1.12 21:22:27 INFO - PID 16789 | Values: 162.0 160.0 160.0 162.0 161.0 160.0 160.0 161.0 163.0 162.0 21:22:27 INFO - PID 16789 | 21:22:27 INFO - PID 16789 | [#3] audio-fft Cycles:10 Average:81.10 Median:74.00 stddev:13.76 (18.6%) stddev-sans-first:14.41 21:22:27 INFO - PID 16789 | Values: 75.0 73.0 73.0 111.0 81.0 73.0 74.0 74.0 102.0 75.0 21:22:27 INFO - PID 16789 | 21:22:27 INFO - PID 16789 | [#4] audio-oscillator Cycles:10 Average:87.50 Median:82.00 stddev:10.42 (12.7%) stddev-sans-first:10.92 21:22:27 INFO - PID 16789 | Values: 83.0 82.0 99.0 82.0 81.0 81.0 94.0 81.0 81.0 111.0 21:22:27 INFO - PID 16789 | 21:22:27 INFO - PID 16789 | [#5] imaging-gaussian-blur Cycles:10 Average:113.00 Median:113.00 stddev:0.47 (0.4%) stddev-sans-first:0.33 21:22:27 INFO - PID 16789 | Values: 114.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 113.0 112.0 21:22:27 INFO - PID 16789 | 21:22:27 INFO - PID 16789 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.84 (0.6%) stddev-sans-first:0.88 21:22:27 INFO - PID 16789 | Values: 147.0 147.0 146.0 147.0 146.0 147.0 148.0 145.0 146.0 147.0 21:22:27 INFO - PID 16789 | 21:22:27 INFO - PID 16789 | [#7] imaging-desaturate Cycles:10 Average:93.50 Median:93.50 stddev:0.71 (0.8%) stddev-sans-first:0.73 21:22:27 INFO - PID 16789 | Values: 93.0 95.0 93.0 93.0 94.0 94.0 93.0 93.0 93.0 94.0 21:22:27 INFO - PID 16789 | 21:22:27 INFO - PID 16789 | [#8] json-parse-financial Cycles:10 Average:46.50 Median:46.50 stddev:1.27 (2.7%) stddev-sans-first:0.97 21:22:27 INFO - PID 16789 | Values: 49.0 46.0 45.0 45.0 46.0 46.0 48.0 46.0 47.0 47.0 21:22:27 INFO - PID 16789 | 21:22:27 INFO - PID 16789 | [#9] json-stringify-tinderbox Cycles:10 Average:54.00 Median:54.00 stddev:0.82 (1.5%) stddev-sans-first:0.44 21:22:27 INFO - PID 16789 | Values: 56.0 54.0 54.0 54.0 53.0 54.0 53.0 54.0 54.0 54.0 21:22:27 INFO - PID 16789 | 21:22:27 INFO - PID 16789 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.00 stddev:2.72 (3.3%) stddev-sans-first:2.88 21:22:27 INFO - PID 16789 | Values: 82.0 82.0 81.0 90.0 82.0 82.0 81.0 81.0 82.0 81.0 21:22:27 INFO - PID 16789 | 21:22:27 INFO - PID 16789 | [#11] stanford-crypto-ccm Cycles:10 Average:130.20 Median:127.00 stddev:14.36 (11.3%) stddev-sans-first:15.12 21:22:27 INFO - PID 16789 | Values: 135.0 124.0 127.0 127.0 125.0 121.0 131.0 123.0 169.0 120.0 21:22:27 INFO - PID 16789 | 21:22:27 INFO - PID 16789 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.60 Median:181.50 stddev:2.50 (1.4%) stddev-sans-first:2.65 21:22:27 INFO - PID 16789 | Values: 181.0 181.0 185.0 179.0 181.0 180.0 183.0 186.0 182.0 178.0 21:22:27 INFO - PID 16789 | 21:22:27 INFO - PID 16789 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.60 Median:64.50 stddev:1.71 (2.7%) stddev-sans-first:1.74 21:22:27 INFO - PID 16789 | Values: 66.0 68.0 65.0 64.0 66.0 64.0 63.0 64.0 62.0 64.0 21:22:27 INFO - PID 16789 | -------- Summary: end -------- 21:22:27 INFO - PID 16789 | 21:22:28 INFO - TEST-INFO | 16789: exit 0 21:22:29 INFO - TEST-OK | kraken | took 60968ms 21:22:29 INFO - SUITE-END | took 1176s 21:22:29 INFO - Completed test suite (00:19:37) 21:22:29 INFO - javascript benchmark 21:22:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7661.000155958732, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3349.480830471277, 3359.3281343731246, 3380.019794259664, 3393.762436629434, 3415.7438192135596, 5724.771009159628, 5863.618864773786, 5895.616784908983, 5903.557233207505, 5919.940800591993, 5904.498117659993, 5929.140274660172, 5962.10568414738, 5994.0, 6013.368596297391, 4848.175810112271, 5073.441921388644, 5192.039472697554, 5217.634765566393, 5231.346081739783, 5246.317978662769, 5271.551918086967, 5296.496832800897, 5318.840434786963, 5326.280952071459, 5095.770690318926, 5175.249588809639, 5209.791608335662, 5267.499587539178, 5281.445448227958, 5181.96360727856, 5214.947850521522, 5221.164613661796, 5244.318238628992, 5305.814296499604, 5175.353080864892, 5222.033923724123, 5239.738013099368, 5241.0, 5262.0, 5768.423157684198, 5827.504662103726, 5841.766329346821, 5844.707764611795, 5911.76352945886, 6227.3772622737815, 6257.655828929407, 6276.654783986879, 6323.367663233686, 6346.492280617539, 6366.140571022899, 6370.044493325991, 6375.872482550323, 6379.553431259814, 6387.968060159669, 5776.0, 5887.8233652990475, 5887.970560147215, 5893.410658934158, 5952.4047595241, 6226.844328891723, 6307.24313082433, 6426.903596446057, 6432.421082102634, 6468.902966455413, 6190.535709821781, 6210.720517576629, 6214.8135555933395, 6225.0, 6225.0, 6250.593711408744, 6290.937090629035, 6292.653904035231, 6315.084312774622, 6319.24169099711, 6120.051392034242, 6179.876402471926, 6267.934451143316, 6271.655058971709, 6283.05754136874, 6275.278342990615, 6350.777722779773, 6355.269144048493, 6356.968215158895, 6360.4911607072245, 4829.323894654751, 4833.05755377698, 4836.46798852126, 4842.927356089662, 4866.391701037371, 4244.85143019999, 4266.978665106654, 4273.18809426208, 4281.678874084456, 4322.546132656089, 5898.321693005273, 5974.3726908674835, 6018.097285407136, 6046.727897244635, 6049.395060494004, 6322.589031712924, 6348.365163483707, 6397.392247736458, 6399.0, 6400.807975760735, 5946.048632218911, 5991.161237426763, 5991.7902873399225, 5997.100434934708, 6005.849853753691, 5452.40023597404, 5536.972315138479, 5545.251391062236, 5604.523615492647, 5608.4111168326735, 6624.96687516569, 6627.204735431779, 6633.535652504278, 6634.369734875179, 6639.867202656016, 6256.124142620128, 6347.0, 6404.967975160094, 6429.38920802523, 6431.742730290736, 6502.0, 6525.9021114684265, 6549.410553050248, 6565.901511477427, 6618.437432818265, 6253.405926436982, 6306.842328941813, 6316.652584107918, 6318.0, 6322.778702745381, 6355.459785918249, 6413.903791443039, 6431.0031945048595, 6437.969924812008, 6439.388258115471, 6082.482988945812, 6142.109394137914, 6150.2927163375, 6201.131841542278, 6215.0, 6204.286507051746, 6214.347493513297, 6216.968915155395, 6218.0, 6219.222597175353, 6100.572959892765, 6139.723712432862, 6166.660833654192, 6176.0, 6182.721777519932, 6121.418465245794, 6138.694953005908, 6165.630062196283, 6218.129461875251, 6246.9062964054665, 6105.338445949952, 6107.144999699956, 6112.625067133324, 6117.705611546597, 6134.631922084689], "value": 5805.982650410174, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [738.7746737245138, 803.5500119932838, 817.5707753429447, 1125.5216532973484, 1149.195563105826, 29120.271993200153, 29817.0, 36633.816830915806, 37486.8125659372, 37505.0, 38451.23097538047, 38872.0, 38901.41647875284, 38914.41628375577, 38948.22103557934, 5629.521490673298, 7129.85740285194, 7251.129864416251, 7264.709411623555, 7267.23694012129, 5762.193292938992, 7047.260037696045, 7222.916562515612, 7239.058922340115, 7241.167265764452, 7278.199398066208, 7317.048783658117, 7320.487565870391, 7321.26787321269, 7323.890141647879, 5660.688662123582, 7257.129144502667, 7266.292421281048, 7268.0914885639295, 7308.524945878527, 5768.0, 6881.174259088892, 7004.299570043006, 7012.474064445136, 7015.36861682451, 35957.820210898775, 36255.63744362549, 36302.0, 36320.63679363199, 36338.0, 3433.53647257622, 3468.4623883298127, 3478.3738926993133, 3479.617242103392, 3480.6171321154907, 29111.708882911113, 29174.708252917622, 29186.0, 29267.853660731562, 29293.0, 3730.3844865597143, 3769.6418840210135, 3786.8295926683363, 3787.791671458069, 3815.9427608585893, 184179.0, 184605.0, 184607.0, 184749.0, 185078.0, 47959.0, 48297.758511207925, 48353.0, 48370.46998655207, 48383.516164838606, 49422.752886235336, 49615.50384496181, 49749.75125124351, 49775.50224497781, 49880.750596246784, 15523.456679016406, 15632.687346253011, 15637.452689155825, 15650.45223417175, 15675.05949643025, 11126.0, 11404.372759498141, 12804.10371274002, 12805.807912881315, 12807.103502754904, 11878.821817672742, 12003.579874704517, 12844.614661560168, 12940.352982350845, 13105.606831795061, 5390.838274851761, 5513.42109078549, 5552.167174923794, 5594.244776955059, 5613.270274864241, 1068.273573969708, 1094.6590426727196, 1100.9229353945307, 1105.9557617695364, 1108.2353176308322, 26464.251615838224, 26553.46893062128, 26629.46741065168, 26789.732102679114, 26819.597706034427, 1166.597523854269, 1172.9882701172878, 1174.647605718281, 1185.6620863053988, 1198.8920997110301, 13301.0, 13794.724105517833, 13986.510472133426, 14007.789883151761, 14063.367148478343, 220297.0, 220392.65484469492, 220514.0, 220795.0, 220850.0, 52179.21731174035, 52194.0, 52369.738151309764, 52372.738136309075, 52501.7374913123, 1455.4469301665088, 1467.156385078584, 1488.5459934720013, 1495.9850401495846, 1507.2689745473438, 24364.563543646203, 25371.112011079524, 25521.744782551938, 25823.354416139748, 25846.87076564605, 38882.80558597189, 38927.61072389353, 38929.41605875857, 38936.41595376128, 38982.4152637705, 202910.0, 203088.0, 203245.0, 203490.0, 204477.0, 34201.657983420846, 34330.82834585811, 34352.48471272883, 34414.13964650904, 34437.65562344345, 36143.27713445769, 38424.0, 41297.380539292535, 41462.1707565841, 41572.58427415687, 30077.0, 30845.0, 30905.227369315948, 31018.224544385666, 31748.841255793574, 30493.34526171614, 31321.0, 31525.211869703442, 31858.20354491156, 32043.519347209345, 34590.0, 34981.82509087438, 35322.47016294809, 35507.11232219215, 36301.636983629825, 28962.0, 29229.561556576242, 29496.262593435335, 29568.260793480335, 29972.70027299699, 23401.648975265725, 24127.276181714577, 24670.383240419134, 24684.0, 24852.37869053288], "value": 16633.20463151806, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.71084554047854, 440.65188501084145, 451.92769156934895, 461.20902651951906, 465.2672041534584, 19100.90449547752, 19136.425907222787, 19810.207591696315, 20034.799652003476, 20179.697304540445, 20956.16175352984, 21409.357719268446, 22008.229711960084, 22096.779032209673, 22194.1122355106, 5530.972345138279, 5692.829215123553, 5697.800576979786, 5699.059655156915, 5704.258446401962, 5312.654677445973, 5439.238506609078, 5469.835904922858, 5475.945240547603, 5476.945230547703, 5417.64785288957, 5471.890562188773, 5473.589480788937, 5475.616706830523, 5482.616216864821, 5323.148296272597, 5496.7526461309135, 5537.556995440375, 5538.086215774392, 5539.778408863641, 4936.6297527685565, 5004.674696144739, 5009.699418034929, 5010.498950104997, 5024.422191447957, 23738.762612374, 23833.285001449985, 24059.759402405925, 24184.637230441556, 24534.754652453605, 2202.7466841313294, 2250.1224522436264, 2250.313654335427, 2251.887405629712, 2254.0, 16148.354065837353, 16857.241424135944, 16912.069836159008, 16944.152792360455, 17040.233189506376, 2176.9020394082145, 2210.7899749523767, 2265.184533567914, 2275.1354485295483, 2281.555096756133, 94513.52743236309, 94887.52556237175, 95006.52496737472, 96326.51836740841, 97902.0, 11362.375069371099, 11949.283043017273, 12361.505539778487, 12527.0, 12722.809157862639, 16768.916155419145, 17051.91474042622, 17801.643967120584, 17825.46523604294, 17861.48177404909, 9148.405353652124, 9244.537773111317, 9479.336446448682, 9563.234941204686, 9563.474008929576, 8747.081556436482, 8813.647454101892, 8822.206001459772, 8976.640934362684, 9045.457272563668, 7760.095740156415, 8023.959880200561, 8077.717279895175, 8140.308073813792, 8245.299149572353, 2096.3710886734225, 2104.9579008419746, 2122.458773012903, 2159.838012149095, 2170.0560256288563, 1071.0842229893485, 1092.2627226621998, 1095.2606990281688, 1100.8403781451646, 1106.8339749037548, 21610.675839862415, 21707.348779536638, 21731.23940662069, 21910.780892190873, 21966.45083872916, 1121.545773961547, 1122.3378206857992, 1126.4987080748988, 1129.203911242572, 1154.2209008919115, 11343.149263805248, 11790.587329443428, 11815.940920295516, 11838.112141589416, 11853.170278080452, 468525.0, 485249.0, 486728.0, 488601.0, 491030.0, 107337.0, 110003.44998274957, 110025.44987275012, 110502.44748776365, 111155.0, 1218.8842060004285, 1219.646302572262, 1246.9064820138526, 1252.536561472243, 1256.327864592457, 17622.64754704873, 17810.419329013846, 18178.818211817714, 18270.086495674896, 18445.0, 49307.77952379902, 49665.751671241414, 49695.751521242164, 49717.254241185685, 50657.49342506675, 61513.0, 62195.06707399302, 63268.68365658142, 64742.676286620146, 66023.0, 9170.495622740547, 9248.815023699623, 9541.618335266512, 9691.806163876823, 9756.121949024622, 14899.404023838924, 15888.0, 15898.761518577, 16183.271752770917, 16896.915515422344, 13183.340832958505, 13232.536861209812, 13802.17186968785, 13852.307384630527, 13963.441462341392, 12417.503299867903, 12512.937435312766, 12535.373231338579, 12606.369681516071, 13178.27519486399, 13442.327883605585, 13675.452981880613, 13735.862641373458, 14098.78851817203, 14325.140491570539, 9506.429614223169, 9891.35706179096, 9932.404055756677, 9940.751481213027, 10264.948675256876, 12851.357432128169, 13034.348282586023, 13051.347432628141, 13360.799588005993, 14270.571882843531], "value": 10300.719422161656, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1330.3747238797766, 1388.3058470764618, 1390.7079513302206, 1406.416337220053, 1407.5566196648062, 10854.891451085487, 11395.202335836495, 11395.943020284907, 11396.886031139686, 11410.885891141086, 11111.72220694483, 11708.473118709657, 11753.941230293836, 11765.70585735357, 11768.293902365864, 2313.5257272259146, 2356.9175078872245, 2360.079568968104, 2363.5509253241917, 2369.3839601703507, 1953.3749200255925, 2269.80706639935, 2326.5928462519078, 2333.4982978659586, 2338.2751347082376, 2022.888741119238, 2276.271593090212, 2369.597168481362, 2372.4306166519996, 2372.7983121434613, 2251.268337790225, 2298.977010229901, 2306.1697788796105, 2306.988465057664, 2311.884405779713, 2269.8751568663715, 2272.3523795718143, 2311.6879221305076, 2327.650852372141, 2333.0551126793675, 11417.942910285396, 11531.654050378418, 11547.364894930775, 11552.480138393792, 11583.247088939192, 6387.776427825051, 6601.141851559315, 6602.3067577904585, 6604.14146160996, 6604.306547812506, 3712.517372741553, 3960.4851369321805, 4000.879973600797, 4033.69747268956, 4035.7578545287083, 1274.3628185907046, 1321.0950498908278, 1331.3343328335832, 1383.8546952569936, 1413.696055348095, 17434.651306973916, 17570.0, 17582.472525824247, 17591.472255832345, 17593.12034398288, 5020.071286811952, 5090.440051594322, 5199.896002079937, 5378.865528361822, 5453.918191227135, 12592.87407125917, 12626.116171867881, 12627.93686031564, 12634.494620215271, 12640.178388404724, 6369.076483909807, 6416.0, 6421.133147025185, 6425.036244563259, 6439.613623182624, 5885.646861188342, 6029.668368239789, 6036.185115009417, 6066.363031881677, 6165.1985241919165, 4031.5913357260656, 4140.0891803803115, 4141.399497072907, 4170.16596680665, 4212.894677633022, 1037.2376303416982, 1065.888081751405, 1177.5584155941522, 1185.146694380045, 1193.2601786892183, 824.744329257932, 858.759547326737, 865.0527672198932, 880.8502554565739, 891.7592250092439, 6684.598924064571, 6768.796936091925, 6786.524943254023, 6788.0, 7075.787726368218, 623.8970569855923, 627.5763859394981, 627.7740013595102, 639.961602303854, 747.2602123897302, 4366.19225443294, 4451.310046942729, 4455.665825063068, 4461.888452788641, 4480.4623445186135, 14687.77968330476, 15492.612684682748, 15549.689006219813, 15566.377344906303, 15576.688466230611, 14765.187914664582, 15423.768643470132, 15442.305096270695, 15468.149251791034, 15475.767863482057, 9264.44413335202, 9438.498797818584, 9456.385334953206, 9459.195968342769, 9467.573959171854, 6924.203716572457, 7083.964580177066, 7094.432445404252, 7115.395191408581, 7267.454940879349, 13321.86678133245, 13443.0, 13513.729725405241, 13758.449662013807, 13773.793393098911, 13866.098703584235, 13909.513167039106, 14119.505817296345, 14218.0, 14283.143011419348, 8879.644814207359, 9151.86272205904, 9219.44683319003, 9225.58484868169, 9233.815323693623, 10724.839127412939, 10799.40603266828, 10812.621558245424, 10824.458777060958, 10855.728606784893, 8896.2882969361, 9161.541922903694, 9164.770880728036, 9194.95402522983, 9336.06639336061, 8888.288936885163, 8898.688545900863, 8920.286377089687, 9050.683226087318, 9087.591058402255, 7935.920640793518, 8024.317932975762, 8051.315638170821, 8058.879116813136, 8094.51432914027, 5951.672658003851, 5963.552733544915, 5966.2840459143445, 6070.939290607214, 6196.81409557714, 6002.159697642246, 6013.9699301503215, 6027.30685971119, 6033.637981720935, 6264.060390941395], "value": 5301.936546203183, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.7556129664146, 417.80780840813225, 430.7544699521273, 432.35578987308907, 445.0853496065584, 5611.887762244753, 5753.482186603205, 5774.0, 5893.292804863417, 5895.204147440094, 5611.551075913927, 5771.249737534125, 5772.711364431782, 5791.031049443189, 5791.797287094942, 4569.565891240327, 4573.977130114345, 4589.311603259504, 4591.885202869938, 4593.0, 4535.183666939949, 4567.566081222279, 4608.5161058088925, 4611.6310695144475, 4624.098300831322, 4561.726296422209, 4563.657725670588, 4568.109218702354, 4573.7027093239, 4584.15193189261, 4571.200039993005, 4575.428071491064, 4576.427946506687, 4580.977095114503, 4590.97704511477, 4072.859599312197, 4114.7119701620895, 4157.625813676754, 4161.167766446722, 4165.354370072613, 5631.831045068655, 5637.577181711388, 5662.773489060474, 5675.120356344773, 5712.914306285409, 5361.115415956362, 5411.810586629488, 5418.4039755626845, 5440.265564148868, 5456.48163424474, 5995.940040599626, 6170.907436388457, 6184.19605451293, 6197.597156184834, 6212.316645169073, 4644.442666879962, 4662.393888794469, 4670.112678591091, 4677.906441871143, 4697.365855609483, 6151.415615516519, 6283.968580157116, 6297.496200304011, 6318.33657465964, 6356.237251529846, 4816.8073277069225, 4842.080004799077, 4864.513548645107, 4871.610271178297, 4882.218844984785, 4877.219644856806, 4884.340614017062, 4895.461499235082, 4899.5590396863745, 4903.509649035139, 5257.553107985787, 5348.786048558092, 5406.432324605938, 5410.48600382963, 5424.484673955968, 5890.823275301748, 6153.292371377349, 6181.629102253879, 6201.81394558164, 6206.937930620727, 1617.9838201618068, 1653.7106006448823, 1689.9662006759795, 1692.1539230384808, 1695.364238410596, 1128.227164392394, 1168.1530890104775, 1177.8292147638545, 1179.3808250668467, 1191.5293459083614, 5955.910661340084, 5961.612495187799, 5965.13505541694, 5974.581779275409, 5997.160397544348, 6334.954732469183, 6354.110424540568, 6355.9830427132365, 6362.331955144736, 6363.7772677956045, 5768.653880767168, 5902.085176797603, 5969.970150149308, 5970.432808883149, 5995.100734889714, 3334.899953001414, 3336.9165770855925, 3364.4616861302075, 3366.848491817874, 3375.814330211862, 6508.544401891822, 6661.233958094881, 6691.7323307068145, 6700.966495167493, 6713.825080610874, 6512.413882750575, 6518.152640156749, 6526.836829079216, 6549.705263263165, 6555.147830781968, 6429.421352078335, 6507.284198738135, 6586.6198977679305, 6597.109390232257, 6621.33786621334, 6235.3452887446165, 6244.500439964701, 6261.373862613702, 6308.211473565804, 6309.558330916791, 6124.448799608057, 6195.81412557624, 6219.782307619212, 6235.3452887446165, 6263.404976527405, 6564.146660934048, 6619.702113405005, 6626.701798418986, 6650.434713049445, 6655.134832471941, 4838.274258861199, 4843.176659967743, 4847.660663753644, 4850.6119510438375, 4860.076585448754, 6062.696865156637, 6149.200603921461, 6193.721282542207, 6290.2766181889665, 6356.9046464304, 6014.969925150346, 6145.834895028975, 6160.938390616216, 6174.228221472316, 6186.1339412483185, 5952.476118150324, 6159.1377207190135, 6159.23009623797, 6174.289956654862, 6179.567430280017, 6099.84750381244, 6142.846428839315, 6148.231471066117, 6150.570524642651, 6155.1382806406245, 6149.754009839557, 6150.876982460415, 6155.137441421227, 6157.0, 6191.504679625529, 5828.883422331614, 6008.459238668541, 6018.849528761816, 6055.364186760503, 6099.634021958696], "value": 4790.820279499698, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.6533194730424, 865.6494119881448, 877.7279043496517, 878.4026861734018, 880.8106257154712, 13450.260235687045, 16486.67026659466, 17396.848166078926, 17639.73540396895, 17740.645187096252, 16426.0, 16985.0, 17055.232514536845, 17159.91420042901, 17173.0, 998.2100030415007, 1028.7530992561806, 1029.1406675426028, 1029.5675816157195, 1030.4435604773414, 726.0996364508024, 742.2132539508111, 1037.8235699930992, 1038.2732087538716, 1039.6517166749147, 1023.5445226874044, 1053.346924906559, 1054.5676272728183, 1054.662507997441, 1055.5250137438145, 1042.593388578455, 1047.9790404191874, 1048.5596049659123, 1049.1134990932649, 1050.7320633238514, 777.0869228656363, 777.1179711027968, 777.1179711027968, 777.6811507282043, 781.3631890009624, 15947.122908240042, 16268.674626507403, 16348.100854453, 16485.58786030347, 16512.669746605, 17340.826591734047, 17446.127693615268, 17743.73384399235, 17825.46523604294, 17956.281748730034, 13176.538821141214, 13227.272500012496, 13315.533956311483, 13451.192928424325, 13714.51999180024, 3349.330133973215, 3387.3902697514436, 3389.254364039907, 3389.3390788796196, 3390.7965522068753, 87549.12450875473, 90796.0, 91699.0, 91762.0, 92129.99999999933, 12124.939375303067, 14190.858091418953, 14642.85357146415, 14710.852891470948, 14765.483208087666, 20088.89955550213, 22075.448113796963, 26823.865880670473, 27565.724342756715, 27764.305892352448, 8316.958415207886, 8556.101609331055, 8570.142985701505, 8575.914240857637, 8587.871181932276, 4185.895352616209, 4188.958110418856, 4224.239636865333, 4250.468691413574, 4273.487181538236, 4547.272436410225, 4637.072585482917, 4639.188142075191, 4643.628509719214, 4644.16405047088, 716.7276434954788, 745.2845268542152, 747.8915557244169, 748.8165399477163, 751.6617522115071, 644.5230529408298, 650.6974256970436, 661.5931202310544, 665.747016133866, 675.7499725101744, 11010.375642230283, 11050.668479945614, 11582.84171582835, 11634.360110193851, 11894.107941904393, 639.2488825629866, 651.1730102769457, 660.9966950165218, 671.2750229751856, 675.2369822100994, 4799.136155492045, 4932.926006109911, 5136.0, 5162.432132465426, 5195.272661827347, 82676.17323826805, 84522.0, 85503.0, 86464.5676771612, 88065.0, 70313.64843175751, 72079.27920720726, 74612.0, 75910.62044689742, 77365.0, 59103.70448147818, 60347.39652603418, 60488.395116049156, 62163.689181553804, 64654.67672661607, 12098.274103553815, 13265.801012985006, 13289.401976910869, 13320.733585328433, 13354.532591359255, 33145.668543314256, 33374.33251334911, 34297.0, 34306.0, 34321.65678343185, 40161.0, 40602.79698601488, 40660.39009414802, 41144.588554114074, 41835.163296733284, 16474.0, 16601.0, 16696.49910502687, 16907.577310567332, 16928.0, 16681.165941702624, 16744.246508906886, 16745.390676166142, 16848.15759212059, 16853.0, 17395.652086958442, 17527.561810954317, 17588.472345829647, 17661.381851635644, 18081.819181808012, 17383.652326953135, 17628.0, 17767.555811104827, 17804.46586602404, 17851.196696148443, 16766.32934682648, 16772.412965546147, 16881.577960551083, 16928.238229279465, 17096.145192740063, 10209.897901021192, 10334.121599663811, 10369.274150809371, 10489.895101048893, 10608.946955265174, 11847.881521184678, 12118.091143164474, 12180.45187966526, 12217.51129954792, 12290.446929887998], "value": 8000.542231000043, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1478.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 118.0, 109.0, 108.0, 109.0, 109.0, 109.0, 109.0, 110.0, 109.0], "value": 109.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 117.0, 123.0, 158.0, 118.0, 117.0, 119.0, 118.0, 138.0, 117.0], "value": 126.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 160.0, 162.0, 161.0, 160.0, 160.0, 161.0, 163.0, 162.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 73.0, 73.0, 111.0, 81.0, 73.0, 74.0, 74.0, 102.0, 75.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 99.0, 82.0, 81.0, 81.0, 94.0, 81.0, 81.0, 111.0], "value": 87.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0], "value": 113.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 148.0, 145.0, 146.0, 147.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 93.0, 93.0, 94.0, 94.0, 93.0, 93.0, 93.0, 94.0], "value": 93.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 46.0, 45.0, 45.0, 46.0, 46.0, 48.0, 46.0, 47.0, 47.0], "value": 46.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 54.0, 54.0, 53.0, 54.0, 53.0, 54.0, 54.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 81.0, 90.0, 82.0, 82.0, 81.0, 81.0, 82.0, 81.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 124.0, 127.0, 127.0, 125.0, 121.0, 131.0, 123.0, 169.0, 120.0], "value": 130.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 181.0, 185.0, 179.0, 181.0, 180.0, 183.0, 186.0, 182.0, 178.0], "value": 181.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 65.0, 64.0, 66.0, 64.0, 63.0, 64.0, 62.0, 64.0], "value": 64.6, "unit": "score"}]}]} 21:22:29 INFO - Return code: 0 21:22:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:22:29 ERROR - # TBPL SUCCESS # 21:22:29 INFO - Running post-action listener: _resource_record_post_action 21:22:29 INFO - [mozharness: 2017-05-02 04:22:29.626514Z] Finished run-tests step (success) 21:22:29 INFO - Running post-run listener: _resource_record_post_run 21:22:29 INFO - Total resource usage - Wall time: 1194s; CPU: 13.0%; Read bytes: 4096; Write bytes: 356077568; Read time: 28; Write time: 191980 21:22:29 INFO - TinderboxPrint: CPU usage
12.9% 21:22:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 28 21:22:29 INFO - TinderboxPrint: I/O write bytes / time
356,077,568 / 191,980 21:22:29 INFO - TinderboxPrint: CPU idle
8,300.1 (87.1%) 21:22:29 INFO - TinderboxPrint: CPU user
1,185.9 (12.4%) 21:22:29 INFO - TinderboxPrint: Swap in / out
0 / 0 21:22:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108335104; Read time: 0; Write time: 84440 21:22:29 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 247742464; Read time: 0; Write time: 107540 21:22:30 INFO - Running post-run listener: _upload_blobber_files 21:22:30 INFO - Blob upload gear active. 21:22:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:22:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 21:22:30 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'] 21:22:30 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 21:22:30 INFO - (blobuploader) - INFO - Open directory for files ... 21:22:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:22:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:22:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:22:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:22:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:22:31 INFO - (blobuploader) - INFO - Done attempting. 21:22:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:22:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:22:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:22:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:22:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:22:32 INFO - (blobuploader) - INFO - Done attempting. 21:22:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:22:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:22:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:22:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:22:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:22:33 INFO - (blobuploader) - INFO - Done attempting. 21:22:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:22:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:22:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:22:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:22:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:22:36 INFO - (blobuploader) - INFO - Done attempting. 21:22:36 INFO - (blobuploader) - INFO - Iteration through files over. 21:22:36 INFO - Return code: 0 21:22:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:22:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:22:36 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af713b625cf25f9732900615a6ede6c3327353a8e58b8ca0a1171ac3d00cf37c5d50cbbe8cf8659e630298ab51c777167f59108502ce2975ac7f56d0b451d049", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3085ef5edaaeb410974061935d4ec411013e028847784ad19ea6edbae9933f821838522a38b2d54946629501482808a4ad829d19b2587e2833ca99183fb885da", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce5aa2337692c2f59142b0f5cd5e451fd8e621c9057f9d11b67529785bab894d9b680640340727a850c8a42222387e1df7125f2ab55b5c81eb04e37914db3674", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3046e8896c096838b262214de4ee52555baa454f5614301cf7fcd1d93e9d69e4aab10d85d86bcfa035a9fc2ed3a1a479d5585cc1d875c7f678c4d289deee885"} 21:22:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:22:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:22:36 INFO - Contents: 21:22:36 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af713b625cf25f9732900615a6ede6c3327353a8e58b8ca0a1171ac3d00cf37c5d50cbbe8cf8659e630298ab51c777167f59108502ce2975ac7f56d0b451d049", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3085ef5edaaeb410974061935d4ec411013e028847784ad19ea6edbae9933f821838522a38b2d54946629501482808a4ad829d19b2587e2833ca99183fb885da", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce5aa2337692c2f59142b0f5cd5e451fd8e621c9057f9d11b67529785bab894d9b680640340727a850c8a42222387e1df7125f2ab55b5c81eb04e37914db3674", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3046e8896c096838b262214de4ee52555baa454f5614301cf7fcd1d93e9d69e4aab10d85d86bcfa035a9fc2ed3a1a479d5585cc1d875c7f678c4d289deee885"} 21:22:36 INFO - Running post-run listener: copy_logs_to_upload_dir 21:22:36 INFO - Copying logs to upload dir... 21:22:36 INFO - mkdir: /builds/slave/test/build/upload/logs 21:22:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.016954 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2017-05-01 21:22:35.150075) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-01 21:22:35.153274) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af713b625cf25f9732900615a6ede6c3327353a8e58b8ca0a1171ac3d00cf37c5d50cbbe8cf8659e630298ab51c777167f59108502ce2975ac7f56d0b451d049", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3085ef5edaaeb410974061935d4ec411013e028847784ad19ea6edbae9933f821838522a38b2d54946629501482808a4ad829d19b2587e2833ca99183fb885da", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce5aa2337692c2f59142b0f5cd5e451fd8e621c9057f9d11b67529785bab894d9b680640340727a850c8a42222387e1df7125f2ab55b5c81eb04e37914db3674", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3046e8896c096838b262214de4ee52555baa454f5614301cf7fcd1d93e9d69e4aab10d85d86bcfa035a9fc2ed3a1a479d5585cc1d875c7f678c4d289deee885"} build_url:https://queue.taskcluster.net/v1/task/OtmnlyVqTSqBJbbsibWJ-Q/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011219 build_url: 'https://queue.taskcluster.net/v1/task/OtmnlyVqTSqBJbbsibWJ-Q/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/af713b625cf25f9732900615a6ede6c3327353a8e58b8ca0a1171ac3d00cf37c5d50cbbe8cf8659e630298ab51c777167f59108502ce2975ac7f56d0b451d049", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3085ef5edaaeb410974061935d4ec411013e028847784ad19ea6edbae9933f821838522a38b2d54946629501482808a4ad829d19b2587e2833ca99183fb885da", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ce5aa2337692c2f59142b0f5cd5e451fd8e621c9057f9d11b67529785bab894d9b680640340727a850c8a42222387e1df7125f2ab55b5c81eb04e37914db3674", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a3046e8896c096838b262214de4ee52555baa454f5614301cf7fcd1d93e9d69e4aab10d85d86bcfa035a9fc2ed3a1a479d5585cc1d875c7f678c4d289deee885"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-01 21:22:35.178395) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 21:22:35.178723) ========= 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=8ec0ee4e6a493f968516bea6000001a5-1493697702.725869-1813014006 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-01 21:22:35.263616) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-01 21:22:35.263932) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-01 21:22:35.264235) ========= ========= Total master_lag: 0.17 =========