builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1489162449.71 results: success (0) revision: f6e923a823271e69eaf8c316dc765fe0a63c15c0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 08:14:09.708065) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 08:14:09.708614) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 08:14:09.708914) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 08:14:09.723976) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 08:14:09.724337) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-10 08:14:10-- 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% 69.3M=0s 2017-03-10 08:14:10 (69.3 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.175167 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 08:14:09.913414) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 08:14:09.913744) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021471 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 08:14:09.965084) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-10 08:14:09.965574) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f6e923a823271e69eaf8c316dc765fe0a63c15c0 --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 f6e923a823271e69eaf8c316dc765fe0a63c15c0 --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=516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-10 08:14:10,509 truncating revision to first 12 chars 2017-03-10 08:14:10,509 Setting DEBUG logging. 2017-03-10 08:14:10,509 attempt 1/10 2017-03-10 08:14:10,509 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f6e923a82327?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-10 08:14:11,728 unpacking tar archive at: mozilla-central-f6e923a82327/testing/mozharness/ program finished with exit code 0 elapsedTime=1.523764 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-10 08:14:11.503244) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 08:14:11.503564) ========= script_repo_revision: f6e923a823271e69eaf8c316dc765fe0a63c15c0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 08:14:11.503927) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 08:14:11.504203) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 08:14:11.513466) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-03-10 08:14:11.513812) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:14:12 INFO - MultiFileLogger online at 20170310 08:14:12 in /builds/slave/test 08:14:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 08:14:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:14:12 INFO - {'append_to_log': False, 08:14:12 INFO - 'base_work_dir': '/builds/slave/test', 08:14:12 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:14:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:14:12 INFO - 'branch': 'Firefox-Non-PGO', 08:14:12 INFO - 'buildbot_json_path': 'buildprops.json', 08:14:12 INFO - 'config_files': ('talos/linux_config.py',), 08:14:12 INFO - 'default_actions': ('clobber', 08:14:12 INFO - 'read-buildbot-config', 08:14:12 INFO - 'download-and-extract', 08:14:12 INFO - 'populate-webroot', 08:14:12 INFO - 'create-virtualenv', 08:14:12 INFO - 'install', 08:14:12 INFO - 'run-tests'), 08:14:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:14:12 INFO - 'download_minidump_stackwalk': True, 08:14:12 INFO - 'download_symbols': 'ondemand', 08:14:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:14:12 INFO - 'tooltool.py': '/tools/tooltool.py', 08:14:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:14:12 INFO - '/tools/misc-python/virtualenv.py')}, 08:14:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:14:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:14:12 INFO - 'gecko_profile': False, 08:14:12 INFO - 'gecko_profile_interval': 0, 08:14:12 INFO - 'installer_path': 'installer.exe', 08:14:12 INFO - 'log_level': 'info', 08:14:12 INFO - 'log_name': 'talos', 08:14:12 INFO - 'log_to_console': True, 08:14:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:14:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:14:12 INFO - 'opt_config_files': (), 08:14:12 INFO - 'pip_index': False, 08:14:12 INFO - 'suite': 'dromaeojs', 08:14:12 INFO - 'system_bits': '32', 08:14:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:14:12 INFO - 'title': 'talos-linux64-ix-061', 08:14:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:14:12 INFO - 'use_talos_json': True, 08:14:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:14:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:14:12 INFO - 'work_dir': 'build'} 08:14:12 INFO - [mozharness: 2017-03-10 16:14:12.156997Z] Running clobber step. 08:14:12 INFO - Running pre-action listener: _resource_record_pre_action 08:14:12 INFO - Running main action method: clobber 08:14:12 INFO - rmtree: /builds/slave/test/build 08:14:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:14:13 INFO - Running post-action listener: _resource_record_post_action 08:14:13 INFO - [mozharness: 2017-03-10 16:14:13.182229Z] Finished clobber step (success) 08:14:13 INFO - [mozharness: 2017-03-10 16:14:13.182329Z] Running read-buildbot-config step. 08:14:13 INFO - Running pre-action listener: _resource_record_pre_action 08:14:13 INFO - Running main action method: read_buildbot_config 08:14:13 INFO - Using buildbot properties: 08:14:13 INFO - { 08:14:13 INFO - "project": "", 08:14:13 INFO - "product": "firefox", 08:14:13 INFO - "who": "ffxbld@noreply.mozilla.org", 08:14:13 INFO - "installer_path": "public/build/target.tar.bz2", 08:14:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:14:13 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:14:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 08:14:13 INFO - "stage_platform": "linux64", 08:14:13 INFO - "basedir": "/builds/slave/test", 08:14:13 INFO - "buildnumber": 487, 08:14:13 INFO - "platform": "ubuntu64_hw", 08:14:13 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 08:14:13 INFO - "slavebuilddir": "test", 08:14:13 INFO - "taskId": "IfrJr2-PRoKNslKJIezp7w", 08:14:13 INFO - "branch": "mozilla-central", 08:14:13 INFO - "script_repo_revision": "production", 08:14:13 INFO - "revision": "f6e923a823271e69eaf8c316dc765fe0a63c15c0", 08:14:13 INFO - "slavename": "talos-linux64-ix-061", 08:14:13 INFO - "repo_path": "mozilla-central" 08:14:13 INFO - } 08:14:13 INFO - Finding installer, test and symbols from parent task. 08:14:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IfrJr2-PRoKNslKJIezp7w'}, attempt #1 08:14:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IfrJr2-PRoKNslKJIezp7w'}, attempt #1 08:14:14 INFO - Task dependencies: WvtXCtJdQ9uh9h8Z5Q04-w 08:14:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w'}, attempt #1 08:14:14 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w/artifacts/public/build/target.tar.bz2 08:14:14 INFO - Set test_url: https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w/artifacts/public/build/test_packages.json 08:14:14 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w/artifacts/public/build/target.crashreporter-symbols.zip 08:14:14 INFO - Running post-action listener: _resource_record_post_action 08:14:14 INFO - [mozharness: 2017-03-10 16:14:14.559327Z] Finished read-buildbot-config step (success) 08:14:14 INFO - [mozharness: 2017-03-10 16:14:14.559545Z] Running download-and-extract step. 08:14:14 INFO - Running pre-action listener: _resource_record_pre_action 08:14:14 INFO - Running main action method: download_and_extract 08:14:14 INFO - mkdir: /builds/slave/test/build/tests 08:14:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:14 INFO - trying https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w/artifacts/public/build/target.test_packages.json 08:14:14 INFO - Downloading https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:14:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:14:15 INFO - Downloaded 896 bytes. 08:14:15 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:14:15 INFO - Using the following test package requirements: 08:14:15 INFO - {u'common': [u'target.common.tests.zip'], 08:14:15 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:14:15 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:14:15 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:14:15 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:14:15 INFO - u'mozbase': [u'target.common.tests.zip'], 08:14:15 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:14:15 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:14:15 INFO - u'web-platform': [u'target.common.tests.zip', 08:14:15 INFO - u'target.web-platform.tests.zip'], 08:14:15 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:14:15 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:14:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w/artifacts/public/build/target.common.tests.zip 08:14:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:14:15 INFO - Fetch https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w/artifacts/public/build/target.common.tests.zip into memory 08:14:16 INFO - Expected file size: 57498835 08:14:16 INFO - Obtained file size: 57498835 08:14:25 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:14:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w/artifacts/public/build/target.common.tests.zip 08:14:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:14:25 INFO - Fetch https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w/artifacts/public/build/target.common.tests.zip into memory 08:14:26 INFO - Expected file size: 57498835 08:14:26 INFO - Obtained file size: 57498835 08:14:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w/artifacts/public/build/target.talos.tests.zip 08:14:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:14:37 INFO - Fetch https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w/artifacts/public/build/target.talos.tests.zip into memory 08:14:38 INFO - Expected file size: 14404424 08:14:38 INFO - Obtained file size: 14404424 08:14:38 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')]} 08:14:38 INFO - trying https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w/artifacts/public/build/target.tar.bz2 08:14:38 INFO - Downloading https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:14:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:14:39 INFO - Downloaded 61723137 bytes. 08:14:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w/artifacts/public/build/target.tar.bz2 08:14:39 INFO - mkdir: /builds/slave/test/properties 08:14:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:14:39 INFO - Writing to file /builds/slave/test/properties/build_url 08:14:39 INFO - Contents: 08:14:39 INFO - build_url:https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w/artifacts/public/build/target.tar.bz2 08:14:39 INFO - Running post-action listener: _resource_record_post_action 08:14:39 INFO - Running post-action listener: set_extra_try_arguments 08:14:39 INFO - [mozharness: 2017-03-10 16:14:39.560810Z] Finished download-and-extract step (success) 08:14:39 INFO - [mozharness: 2017-03-10 16:14:39.560907Z] Running populate-webroot step. 08:14:39 INFO - Running pre-action listener: _resource_record_pre_action 08:14:39 INFO - Running main action method: populate_webroot 08:14:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:14:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:14:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:14:39 INFO - '--tppagecycles', 08:14:39 INFO - '7'], 08:14:39 INFO - 'tests': ['tsvgm']}}, 08:14:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:14:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:14:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:14:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:14:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:14:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:14:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:14:39 INFO - 'talos_options': ['--disable-e10s'], 08:14:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:14:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:14:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:14:39 INFO - 'talos_options': ['--disable-e10s'], 08:14:39 INFO - 'tests': ['damp', 'tps']}, 08:14:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:14:39 INFO - 'tests': ['damp', 'tps']}, 08:14:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:14:39 INFO - 'tests': ['dromaeo_dom']}, 08:14:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:14:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:14:39 INFO - 'tests': ['basic_compositor_video']}, 08:14:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:14:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:14:39 INFO - 'tests': ['a11yr', 08:14:39 INFO - 'ts_paint', 08:14:39 INFO - 'tpaint', 08:14:39 INFO - 'sessionrestore', 08:14:39 INFO - 'sessionrestore_no_auto_restore', 08:14:39 INFO - 'tabpaint']}, 08:14:39 INFO - 'other-e10s': {'tests': ['a11yr', 08:14:39 INFO - 'ts_paint', 08:14:39 INFO - 'tpaint', 08:14:39 INFO - 'sessionrestore', 08:14:39 INFO - 'sessionrestore_no_auto_restore', 08:14:39 INFO - 'tabpaint']}, 08:14:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:14:39 INFO - 'ts_paint', 08:14:39 INFO - 'tpaint', 08:14:39 INFO - 'sessionrestore', 08:14:39 INFO - 'sessionrestore_no_auto_restore', 08:14:39 INFO - 'tabpaint']}, 08:14:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:14:39 INFO - 'ts_paint', 08:14:39 INFO - 'tpaint', 08:14:39 INFO - 'sessionrestore', 08:14:39 INFO - 'sessionrestore_no_auto_restore', 08:14:39 INFO - 'tabpaint']}, 08:14:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:14:39 INFO - 'tests': ['a11yr', 08:14:39 INFO - 'ts_paint', 08:14:39 INFO - 'tpaint', 08:14:39 INFO - 'sessionrestore', 08:14:39 INFO - 'sessionrestore_no_auto_restore', 08:14:39 INFO - 'tabpaint']}, 08:14:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:14:39 INFO - 'tests': ['a11yr', 08:14:39 INFO - 'ts_paint', 08:14:39 INFO - 'tpaint', 08:14:39 INFO - 'sessionrestore', 08:14:39 INFO - 'sessionrestore_no_auto_restore', 08:14:39 INFO - 'tabpaint']}, 08:14:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:14:39 INFO - 'tests': ['tsvgx', 08:14:39 INFO - 'tsvgr_opacity', 08:14:39 INFO - 'tart', 08:14:39 INFO - 'tscrollx', 08:14:39 INFO - 'cart', 08:14:39 INFO - 'tsvg_static']}, 08:14:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:14:39 INFO - 'tsvgr_opacity', 08:14:39 INFO - 'tart', 08:14:39 INFO - 'tscrollx', 08:14:39 INFO - 'cart', 08:14:39 INFO - 'tsvg_static']}, 08:14:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:14:39 INFO - 'talos_options': ['--disable-e10s'], 08:14:39 INFO - 'tests': ['tp5o']}, 08:14:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:14:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:14:39 INFO - 'talos_options': ['--disable-e10s', 08:14:39 INFO - '--xperf_path', 08:14:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:39 INFO - 'tests': ['tp5n']}, 08:14:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:14:39 INFO - 'talos_options': ['--xperf_path', 08:14:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:14:39 INFO - 'tests': ['tp5n']}}, 08:14:39 INFO - 'talos.zip': {'path': '', 08:14:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:14:39 INFO - Running post-action listener: _resource_record_post_action 08:14:39 INFO - [mozharness: 2017-03-10 16:14:39.574086Z] Finished populate-webroot step (success) 08:14:39 INFO - [mozharness: 2017-03-10 16:14:39.574177Z] Running create-virtualenv step. 08:14:39 INFO - Running pre-action listener: _resource_record_pre_action 08:14:39 INFO - Running main action method: create_virtualenv 08:14:39 INFO - Creating virtualenv /builds/slave/test/build/venv 08:14:39 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 08:14:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:14:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:14:39 INFO - Using real prefix '/usr' 08:14:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:14:40 INFO - Installing distribute.............................................................................................................................................................................................done. 08:14:42 INFO - Installing pip.................done. 08:14:42 INFO - Return code: 0 08:14:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:14:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:14:42 INFO - Reading from file tmpfile_stdout 08:14:42 INFO - Output received: 08:14:42 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) 08:14:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:42 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 0x284d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2945a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8290>, '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 0x2ae8b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799', '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 08:14:42 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 08:14:42 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 08:14:42 INFO - Using env: {'DISPLAY': ':0', 08:14:42 INFO - 'HOME': '/home/cltbld', 08:14:42 INFO - 'LANG': 'en_US.UTF-8', 08:14:42 INFO - 'LANGUAGE': 'en_US:en', 08:14:42 INFO - 'LOGNAME': 'cltbld', 08:14:42 INFO - 'MAIL': '/var/mail/cltbld', 08:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:42 INFO - 'MOZ_NO_REMOTE': '1', 08:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:42 INFO - 'NO_EM_RESTART': '1', 08:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:42 INFO - 'PWD': '/builds/slave/test', 08:14:42 INFO - 'SHELL': '/bin/bash', 08:14:42 INFO - 'SHLVL': '1', 08:14:42 INFO - 'TERM': 'linux', 08:14:42 INFO - 'TMOUT': '86400', 08:14:42 INFO - 'USER': 'cltbld', 08:14:42 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799', 08:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:42 INFO - '_': '/tools/buildbot/bin/python'} 08:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:42 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 08:14:42 INFO - Cleaning up... 08:14:42 INFO - Return code: 0 08:14:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:42 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 0x284d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2945a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8290>, '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 0x2ae8b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799', '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 08:14:42 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 08:14:42 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 08:14:42 INFO - Using env: {'DISPLAY': ':0', 08:14:42 INFO - 'HOME': '/home/cltbld', 08:14:42 INFO - 'LANG': 'en_US.UTF-8', 08:14:42 INFO - 'LANGUAGE': 'en_US:en', 08:14:42 INFO - 'LOGNAME': 'cltbld', 08:14:42 INFO - 'MAIL': '/var/mail/cltbld', 08:14:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:42 INFO - 'MOZ_NO_REMOTE': '1', 08:14:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:42 INFO - 'NO_EM_RESTART': '1', 08:14:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:42 INFO - 'PWD': '/builds/slave/test', 08:14:42 INFO - 'SHELL': '/bin/bash', 08:14:42 INFO - 'SHLVL': '1', 08:14:42 INFO - 'TERM': 'linux', 08:14:42 INFO - 'TMOUT': '86400', 08:14:42 INFO - 'USER': 'cltbld', 08:14:42 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799', 08:14:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:42 INFO - '_': '/tools/buildbot/bin/python'} 08:14:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:42 INFO - Downloading/unpacking psutil>=3.1.1 08:14:42 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 08:14:42 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 08:14:42 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 08:14:42 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 08:14:42 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 08:14:42 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 08:14:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:14:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:44 INFO - Installing collected packages: psutil 08:14:44 INFO - Running setup.py install for psutil 08:14:44 INFO - building 'psutil._psutil_linux' extension 08:14:44 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 08:14:45 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 08:14:45 INFO - building 'psutil._psutil_posix' extension 08:14:45 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 08:14:45 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 08:14:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:14:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:14:45 INFO - Successfully installed psutil 08:14:45 INFO - Cleaning up... 08:14:45 INFO - Return code: 0 08:14:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:14:45 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')]} 08:14:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:45 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')]} 08:14:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:45 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 0x284d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2945a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8290>, '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 0x2ae8b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799', '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 08:14:45 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 08:14:45 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 08:14:45 INFO - Using env: {'DISPLAY': ':0', 08:14:45 INFO - 'HOME': '/home/cltbld', 08:14:45 INFO - 'LANG': 'en_US.UTF-8', 08:14:45 INFO - 'LANGUAGE': 'en_US:en', 08:14:45 INFO - 'LOGNAME': 'cltbld', 08:14:45 INFO - 'MAIL': '/var/mail/cltbld', 08:14:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:45 INFO - 'MOZ_NO_REMOTE': '1', 08:14:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:45 INFO - 'NO_EM_RESTART': '1', 08:14:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:45 INFO - 'PWD': '/builds/slave/test', 08:14:45 INFO - 'SHELL': '/bin/bash', 08:14:45 INFO - 'SHLVL': '1', 08:14:45 INFO - 'TERM': 'linux', 08:14:45 INFO - 'TMOUT': '86400', 08:14:45 INFO - 'USER': 'cltbld', 08:14:45 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799', 08:14:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:45 INFO - '_': '/tools/buildbot/bin/python'} 08:14:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:14:45 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 08:14:45 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 08:14:45 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 08:14:45 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 08:14:45 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 08:14:45 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 08:14:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:14:47 INFO - Installing collected packages: mozsystemmonitor 08:14:47 INFO - Running setup.py install for mozsystemmonitor 08:14:47 INFO - Successfully installed mozsystemmonitor 08:14:47 INFO - Cleaning up... 08:14:47 INFO - Return code: 0 08:14:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:14:47 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')]} 08:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:47 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')]} 08:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:47 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 0x284d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2945a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8290>, '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 0x2ae8b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799', '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 08:14:47 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 08:14:47 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 08:14:47 INFO - Using env: {'DISPLAY': ':0', 08:14:47 INFO - 'HOME': '/home/cltbld', 08:14:47 INFO - 'LANG': 'en_US.UTF-8', 08:14:47 INFO - 'LANGUAGE': 'en_US:en', 08:14:47 INFO - 'LOGNAME': 'cltbld', 08:14:47 INFO - 'MAIL': '/var/mail/cltbld', 08:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:47 INFO - 'MOZ_NO_REMOTE': '1', 08:14:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:47 INFO - 'NO_EM_RESTART': '1', 08:14:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:47 INFO - 'PWD': '/builds/slave/test', 08:14:47 INFO - 'SHELL': '/bin/bash', 08:14:47 INFO - 'SHLVL': '1', 08:14:47 INFO - 'TERM': 'linux', 08:14:47 INFO - 'TMOUT': '86400', 08:14:47 INFO - 'USER': 'cltbld', 08:14:47 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799', 08:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:47 INFO - '_': '/tools/buildbot/bin/python'} 08:14:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:48 INFO - Downloading/unpacking jsonschema==2.5.1 08:14:48 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 08:14:48 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 08:14:48 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 08:14:48 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 08:14:48 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 08:14:48 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 08:14:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:14:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:14:50 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 08:14:50 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 08:14:50 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 08:14:50 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 08:14:50 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 08:14:50 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 08:14:50 INFO - Downloading functools32-3.2.3-2.tar.gz 08:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:14:50 INFO - warning: no files found matching '*.txt' 08:14:50 INFO - no previously-included directories found matching 'build' 08:14:50 INFO - no previously-included directories found matching 'dist' 08:14:50 INFO - no previously-included directories found matching '.git*' 08:14:50 INFO - Installing collected packages: jsonschema, functools32 08:14:50 INFO - Running setup.py install for functools32 08:14:50 INFO - warning: no files found matching '*.txt' 08:14:50 INFO - no previously-included directories found matching 'build' 08:14:50 INFO - no previously-included directories found matching 'dist' 08:14:50 INFO - no previously-included directories found matching '.git*' 08:14:50 INFO - Successfully installed jsonschema functools32 08:14:50 INFO - Cleaning up... 08:14:50 INFO - Return code: 0 08:14:50 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x284d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2945a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8290>, '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 0x2ae8b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799', '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 08:14:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:14:50 INFO - Using env: {'DISPLAY': ':0', 08:14:50 INFO - 'HOME': '/home/cltbld', 08:14:50 INFO - 'LANG': 'en_US.UTF-8', 08:14:50 INFO - 'LANGUAGE': 'en_US:en', 08:14:50 INFO - 'LOGNAME': 'cltbld', 08:14:50 INFO - 'MAIL': '/var/mail/cltbld', 08:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:50 INFO - 'MOZ_NO_REMOTE': '1', 08:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:50 INFO - 'NO_EM_RESTART': '1', 08:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:50 INFO - 'PWD': '/builds/slave/test', 08:14:50 INFO - 'SHELL': '/bin/bash', 08:14:50 INFO - 'SHLVL': '1', 08:14:50 INFO - 'TERM': 'linux', 08:14:50 INFO - 'TMOUT': '86400', 08:14:50 INFO - 'USER': 'cltbld', 08:14:50 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799', 08:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:50 INFO - '_': '/tools/buildbot/bin/python'} 08:14:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:50 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:14:50 INFO - Cleaning up... 08:14:50 INFO - Return code: 0 08:14:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x284d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2945a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8290>, '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 0x2ae8b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799', '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 08:14:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:14:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:14:50 INFO - Using env: {'DISPLAY': ':0', 08:14:50 INFO - 'HOME': '/home/cltbld', 08:14:50 INFO - 'LANG': 'en_US.UTF-8', 08:14:50 INFO - 'LANGUAGE': 'en_US:en', 08:14:50 INFO - 'LOGNAME': 'cltbld', 08:14:50 INFO - 'MAIL': '/var/mail/cltbld', 08:14:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:50 INFO - 'MOZ_NO_REMOTE': '1', 08:14:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:50 INFO - 'NO_EM_RESTART': '1', 08:14:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:50 INFO - 'PWD': '/builds/slave/test', 08:14:50 INFO - 'SHELL': '/bin/bash', 08:14:50 INFO - 'SHLVL': '1', 08:14:50 INFO - 'TERM': 'linux', 08:14:50 INFO - 'TMOUT': '86400', 08:14:50 INFO - 'USER': 'cltbld', 08:14:50 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799', 08:14:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:50 INFO - '_': '/tools/buildbot/bin/python'} 08:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:51 INFO - Downloading/unpacking blobuploader==1.2.4 08:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:53 INFO - Downloading blobuploader-1.2.4.tar.gz 08:14:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:14:53 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:14:53 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 08:14:53 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 08:14:53 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 08:14:53 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 08:14:53 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 08:14:53 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 08:14:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:14:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:14:53 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 08:14:53 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 08:14:53 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 08:14:53 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 08:14:53 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 08:14:53 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 08:14:53 INFO - Downloading docopt-0.6.1.tar.gz 08:14:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:14:53 INFO - Installing collected packages: blobuploader, requests, docopt 08:14:53 INFO - Running setup.py install for blobuploader 08:14:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:14:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:14:53 INFO - Running setup.py install for requests 08:14:54 INFO - Running setup.py install for docopt 08:14:54 INFO - Successfully installed blobuploader requests docopt 08:14:54 INFO - Cleaning up... 08:14:54 INFO - Return code: 0 08:14:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:14:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:54 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 0x284d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2945a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8290>, '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 0x2ae8b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799', '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 08:14:54 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 08:14:54 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 08:14:54 INFO - Using env: {'DISPLAY': ':0', 08:14:54 INFO - 'HOME': '/home/cltbld', 08:14:54 INFO - 'LANG': 'en_US.UTF-8', 08:14:54 INFO - 'LANGUAGE': 'en_US:en', 08:14:54 INFO - 'LOGNAME': 'cltbld', 08:14:54 INFO - 'MAIL': '/var/mail/cltbld', 08:14:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:54 INFO - 'MOZ_NO_REMOTE': '1', 08:14:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:54 INFO - 'NO_EM_RESTART': '1', 08:14:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:54 INFO - 'PWD': '/builds/slave/test', 08:14:54 INFO - 'SHELL': '/bin/bash', 08:14:54 INFO - 'SHLVL': '1', 08:14:54 INFO - 'TERM': 'linux', 08:14:54 INFO - 'TMOUT': '86400', 08:14:54 INFO - 'USER': 'cltbld', 08:14:54 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799', 08:14:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:54 INFO - '_': '/tools/buildbot/bin/python'} 08:14:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:54 INFO - Running setup.py (path:/tmp/pip-Z5hepL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:54 INFO - Running setup.py (path:/tmp/pip-bllD_h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:54 INFO - Running setup.py (path:/tmp/pip-RKT9RY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:54 INFO - Running setup.py (path:/tmp/pip-0IaF6X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:54 INFO - Running setup.py (path:/tmp/pip-4VZlrY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:55 INFO - Running setup.py (path:/tmp/pip-lCxSbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:55 INFO - Running setup.py (path:/tmp/pip-VBuicZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:55 INFO - Running setup.py (path:/tmp/pip-X_yn4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:55 INFO - Running setup.py (path:/tmp/pip-xWeMGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:55 INFO - Running setup.py (path:/tmp/pip-aCOSQZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:55 INFO - Running setup.py (path:/tmp/pip-CcKvPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:55 INFO - Running setup.py (path:/tmp/pip-KhDHoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:55 INFO - Running setup.py (path:/tmp/pip-1u4C2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:55 INFO - Running setup.py (path:/tmp/pip-p9S3sL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:55 INFO - Running setup.py (path:/tmp/pip-TNYANC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:55 INFO - Running setup.py (path:/tmp/pip-c85LSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:55 INFO - Running setup.py (path:/tmp/pip-gYZ6_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:14:55 INFO - Running setup.py install for manifestparser 08:14:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:14:56 INFO - Running setup.py install for mozcrash 08:14:56 INFO - Running setup.py install for mozdebug 08:14:56 INFO - Running setup.py install for mozdevice 08:14:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:14:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:14:56 INFO - Running setup.py install for mozfile 08:14:56 INFO - Running setup.py install for mozhttpd 08:14:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:14:56 INFO - Running setup.py install for mozinfo 08:14:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:14:56 INFO - Running setup.py install for mozInstall 08:14:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:14:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:14:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:14:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:14:56 INFO - Running setup.py install for mozleak 08:14:56 INFO - Running setup.py install for mozlog 08:14:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:14:56 INFO - Running setup.py install for moznetwork 08:14:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:14:57 INFO - Running setup.py install for mozprocess 08:14:57 INFO - Running setup.py install for mozprofile 08:14:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:14:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:14:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:14:57 INFO - Running setup.py install for mozrunner 08:14:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:14:57 INFO - Running setup.py install for mozscreenshot 08:14:57 INFO - Running setup.py install for moztest 08:14:57 INFO - Running setup.py install for mozversion 08:14:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:14:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:14:57 INFO - Cleaning up... 08:14:57 INFO - Return code: 0 08:14:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:14:57 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')]} 08:14:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:14:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:57 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')]} 08:14:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:14:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:14:57 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 0x284d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2945a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8290>, '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 0x2ae8b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799', '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 08:14:57 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 08:14:57 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 08:14:57 INFO - Using env: {'DISPLAY': ':0', 08:14:57 INFO - 'HOME': '/home/cltbld', 08:14:57 INFO - 'LANG': 'en_US.UTF-8', 08:14:57 INFO - 'LANGUAGE': 'en_US:en', 08:14:57 INFO - 'LOGNAME': 'cltbld', 08:14:57 INFO - 'MAIL': '/var/mail/cltbld', 08:14:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:14:57 INFO - 'MOZ_NO_REMOTE': '1', 08:14:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:14:57 INFO - 'NO_EM_RESTART': '1', 08:14:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:14:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:14:57 INFO - 'PWD': '/builds/slave/test', 08:14:57 INFO - 'SHELL': '/bin/bash', 08:14:57 INFO - 'SHLVL': '1', 08:14:57 INFO - 'TERM': 'linux', 08:14:57 INFO - 'TMOUT': '86400', 08:14:57 INFO - 'USER': 'cltbld', 08:14:57 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799', 08:14:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:14:57 INFO - '_': '/tools/buildbot/bin/python'} 08:14:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:14:57 INFO - Running setup.py (path:/tmp/pip-yU1W35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:14:58 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)) 08:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:14:58 INFO - Running setup.py (path:/tmp/pip-BPEilZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:14:58 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)) 08:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:14:58 INFO - Running setup.py (path:/tmp/pip-Zk52Cb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:14:58 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)) 08:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:14:58 INFO - Running setup.py (path:/tmp/pip-7J3pYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:14:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:14:58 INFO - Running setup.py (path:/tmp/pip-akywwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:14:58 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)) 08:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:14:58 INFO - Running setup.py (path:/tmp/pip-lVZu07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:14:58 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)) 08:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:14:58 INFO - Running setup.py (path:/tmp/pip-4bC5cG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:14:58 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)) 08:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:14:58 INFO - Running setup.py (path:/tmp/pip-jdSm9M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:14:58 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)) 08:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:14:58 INFO - Running setup.py (path:/tmp/pip-WlkUer-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:14:58 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)) 08:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:14:58 INFO - Running setup.py (path:/tmp/pip-kV7Kwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:14:58 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)) 08:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:14:58 INFO - Running setup.py (path:/tmp/pip-e0e1dV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:14:58 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)) 08:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:14:58 INFO - Running setup.py (path:/tmp/pip-hTxhDx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:14:58 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)) 08:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:14:58 INFO - Running setup.py (path:/tmp/pip-MqJBtn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:14:58 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)) 08:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:14:58 INFO - Running setup.py (path:/tmp/pip-sboZTE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:14:58 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)) 08:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:58 INFO - Running setup.py (path:/tmp/pip-WwBfrR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:14:59 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)) 08:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:14:59 INFO - Running setup.py (path:/tmp/pip-HKuzPX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:14:59 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)) 08:14:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:14:59 INFO - Running setup.py (path:/tmp/pip-2h5ZVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:14:59 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)) 08:14:59 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)) 08:14:59 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)) 08:14:59 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)) 08:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:14:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:14:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:14:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:14:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:14:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:15:01 INFO - Downloading blessings-1.6.tar.gz 08:15:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:15:01 INFO - Installing collected packages: blessings 08:15:01 INFO - Running setup.py install for blessings 08:15:01 INFO - Successfully installed blessings 08:15:01 INFO - Cleaning up... 08:15:01 INFO - Return code: 0 08:15:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:15:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:15:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:15:01 INFO - Reading from file tmpfile_stdout 08:15:01 INFO - Current package versions: 08:15:01 INFO - argparse == 1.2.1 08:15:01 INFO - blessings == 1.6 08:15:01 INFO - blobuploader == 1.2.4 08:15:01 INFO - docopt == 0.6.1 08:15:01 INFO - functools32 == 3.2.3-2 08:15:01 INFO - jsonschema == 2.5.1 08:15:01 INFO - manifestparser == 1.1 08:15:01 INFO - mozInstall == 1.12 08:15:01 INFO - mozcrash == 1.0 08:15:01 INFO - mozdebug == 0.1 08:15:01 INFO - mozdevice == 0.49 08:15:01 INFO - mozfile == 1.2 08:15:01 INFO - mozhttpd == 0.7 08:15:01 INFO - mozinfo == 0.9 08:15:01 INFO - mozleak == 0.1 08:15:01 INFO - mozlog == 3.4 08:15:01 INFO - moznetwork == 0.27 08:15:01 INFO - mozprocess == 0.25 08:15:01 INFO - mozprofile == 0.28 08:15:01 INFO - mozrunner == 6.13 08:15:01 INFO - mozscreenshot == 0.1 08:15:01 INFO - mozsystemmonitor == 0.3 08:15:01 INFO - moztest == 0.8 08:15:01 INFO - mozversion == 1.4 08:15:01 INFO - psutil == 3.1.1 08:15:01 INFO - requests == 1.2.3 08:15:01 INFO - wsgiref == 0.1.2 08:15:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:15:01 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')]} 08:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:01 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')]} 08:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:01 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 0x284d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2945a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8290>, '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 0x2ae8b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799', '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 08:15:01 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 08:15:01 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 08:15:01 INFO - Using env: {'DISPLAY': ':0', 08:15:01 INFO - 'HOME': '/home/cltbld', 08:15:01 INFO - 'LANG': 'en_US.UTF-8', 08:15:01 INFO - 'LANGUAGE': 'en_US:en', 08:15:01 INFO - 'LOGNAME': 'cltbld', 08:15:01 INFO - 'MAIL': '/var/mail/cltbld', 08:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:01 INFO - 'MOZ_NO_REMOTE': '1', 08:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:01 INFO - 'NO_EM_RESTART': '1', 08:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:01 INFO - 'PWD': '/builds/slave/test', 08:15:01 INFO - 'SHELL': '/bin/bash', 08:15:01 INFO - 'SHLVL': '1', 08:15:01 INFO - 'TERM': 'linux', 08:15:01 INFO - 'TMOUT': '86400', 08:15:01 INFO - 'USER': 'cltbld', 08:15:01 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799', 08:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:01 INFO - '_': '/tools/buildbot/bin/python'} 08:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:01 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)) 08:15:01 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)) 08:15:01 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)) 08:15:01 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)) 08:15:01 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)) 08:15:01 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)) 08:15:01 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)) 08:15:01 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)) 08:15:01 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)) 08:15:01 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)) 08:15:01 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)) 08:15:01 INFO - Cleaning up... 08:15:01 INFO - Return code: 0 08:15:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:15:01 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')]} 08:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:01 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')]} 08:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:15:01 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 0x284d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2945a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2aeab10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ae8290>, '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 0x2ae8b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9040>, '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': '516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799', '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 08:15:01 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 08:15:01 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 08:15:01 INFO - Using env: {'DISPLAY': ':0', 08:15:01 INFO - 'HOME': '/home/cltbld', 08:15:01 INFO - 'LANG': 'en_US.UTF-8', 08:15:01 INFO - 'LANGUAGE': 'en_US:en', 08:15:01 INFO - 'LOGNAME': 'cltbld', 08:15:01 INFO - 'MAIL': '/var/mail/cltbld', 08:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:01 INFO - 'MOZ_NO_REMOTE': '1', 08:15:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:01 INFO - 'NO_EM_RESTART': '1', 08:15:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:01 INFO - 'PWD': '/builds/slave/test', 08:15:01 INFO - 'SHELL': '/bin/bash', 08:15:01 INFO - 'SHLVL': '1', 08:15:01 INFO - 'TERM': 'linux', 08:15:01 INFO - 'TMOUT': '86400', 08:15:01 INFO - 'USER': 'cltbld', 08:15:01 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799', 08:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:01 INFO - '_': '/tools/buildbot/bin/python'} 08:15:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:15:02 INFO - Cleaning up... 08:15:02 INFO - Return code: 0 08:15:02 INFO - Running post-action listener: _resource_record_post_action 08:15:02 INFO - Running post-action listener: _start_resource_monitoring 08:15:02 INFO - Starting resource monitoring. 08:15:02 INFO - [mozharness: 2017-03-10 16:15:02.174282Z] Finished create-virtualenv step (success) 08:15:02 INFO - [mozharness: 2017-03-10 16:15:02.174755Z] Running install step. 08:15:02 INFO - Running pre-action listener: _resource_record_pre_action 08:15:02 INFO - Running main action method: install 08:15:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:15:02 INFO - Reading from file tmpfile_stdout 08:15:02 INFO - Detecting whether we're running mozinstall >=1.0... 08:15:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:15:02 INFO - Reading from file tmpfile_stdout 08:15:02 INFO - Output received: 08:15:02 INFO - Usage: mozinstall [options] installer 08:15:02 INFO - Options: 08:15:02 INFO - -h, --help show this help message and exit 08:15:02 INFO - -d DEST, --destination=DEST 08:15:02 INFO - Directory to install application into. [default: 08:15:02 INFO - "/builds/slave/test"] 08:15:02 INFO - --app=APP Application being installed. [default: firefox] 08:15:02 INFO - mkdir: /builds/slave/test/build/application 08:15:02 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'] 08:15:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:15:17 INFO - Reading from file tmpfile_stdout 08:15:17 INFO - Output received: 08:15:17 INFO - /builds/slave/test/build/application/firefox/firefox 08:15:17 INFO - Running post-action listener: _resource_record_post_action 08:15:17 INFO - [mozharness: 2017-03-10 16:15:17.876465Z] Finished install step (success) 08:15:17 INFO - [mozharness: 2017-03-10 16:15:17.876737Z] Running run-tests step. 08:15:17 INFO - Running pre-action listener: _resource_record_pre_action 08:15:17 INFO - Running main action method: run_tests 08:15:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:15:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:15:17 INFO - Python 2.7.3 08:15:17 INFO - Return code: 0 08:15:17 INFO - grabbing minidump binary from tooltool 08:15:17 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')]} 08:15:17 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 0x2ae8290>, '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 0x2ae8b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ae9040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:15:17 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 08:15:17 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 08:15:17 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 08:15:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:15:17 INFO - Return code: 0 08:15:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:15:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:15:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:15:17 INFO - ENV: RUST_BACKTRACE is now 1 08:15:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:15:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:15:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 08:15:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-061 --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 08:15:17 INFO - Using env: {'DISPLAY': ':0', 08:15:17 INFO - 'HOME': '/home/cltbld', 08:15:17 INFO - 'LANG': 'en_US.UTF-8', 08:15:17 INFO - 'LANGUAGE': 'en_US:en', 08:15:17 INFO - 'LOGNAME': 'cltbld', 08:15:17 INFO - 'MAIL': '/var/mail/cltbld', 08:15:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:15:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:15:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:15:17 INFO - 'MOZ_NO_REMOTE': '1', 08:15:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:15:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:15:17 INFO - 'NO_EM_RESTART': '1', 08:15:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:15:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:15:17 INFO - 'PWD': '/builds/slave/test', 08:15:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:15:17 INFO - 'RUST_BACKTRACE': '1', 08:15:17 INFO - 'SHELL': '/bin/bash', 08:15:17 INFO - 'SHLVL': '1', 08:15:17 INFO - 'TERM': 'linux', 08:15:17 INFO - 'TMOUT': '86400', 08:15:17 INFO - 'USER': 'cltbld', 08:15:17 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799', 08:15:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:15:17 INFO - '_': '/tools/buildbot/bin/python'} 08:15:17 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--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 08:15:18 INFO - mozversion application_buildid: 20170310154529 08:15:18 INFO - mozversion application_changeset: f6e923a823271e69eaf8c316dc765fe0a63c15c0 08:15:18 INFO - mozversion application_display_name: Nightly 08:15:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:15:18 INFO - mozversion application_name: Firefox 08:15:18 INFO - mozversion application_remotingname: firefox 08:15:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:15:18 INFO - mozversion application_vendor: Mozilla 08:15:18 INFO - mozversion application_version: 55.0a1 08:15:18 INFO - mozversion platform_buildid: 20170310154529 08:15:18 INFO - mozversion platform_changeset: f6e923a823271e69eaf8c316dc765fe0a63c15c0 08:15:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:15:18 INFO - mozversion platform_version: 55.0a1 08:15:18 INFO - using testdate: 1489162518 08:15:18 INFO - actual date: 1489162518 08:15:18 INFO - starting webserver on 'localhost:46806' 08:15:18 INFO - SUITE-START | Running 2 tests 08:15:18 INFO - TEST-START | dromaeo_css 08:15:18 INFO - operating with platform_type : linux_ 08:15:18 INFO - Initialising browser for dromaeo_css test... 08:15:18 INFO - TEST-INFO | started process 11694 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQwFcDP/profile http://localhost:46806/getInfo.html) 08:15:22 INFO - PROCESS | 11694 | __metrics Screen width/height:1600/1200 08:15:22 INFO - PROCESS | 11694 | colorDepth:24 08:15:22 INFO - PROCESS | 11694 | Browser inner width/height: 1024/697 08:15:22 INFO - PROCESS | 11694 | __metrics 08:15:23 INFO - PROCESS | 11694 | 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" 08:15:23 INFO - PROCESS | 11694 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:15:24 INFO - TEST-INFO | 11694: exit 0 08:15:24 INFO - Browser initialized. 08:15:24 INFO - Running cycle 1/1 for dromaeo_css test... 08:15:24 INFO - TEST-INFO | started process 11785 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQwFcDP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:15:36 INFO - PROCESS | 11785 | RSS: Main: 151621632 08:15:36 INFO - PROCESS | 11785 | 08:18:42 INFO - PROCESS | 11785 | Cycle 1(1): loaded http://localhost:46806/tests/dromaeo/cssquery-dojo.html (next: http://localhost:46806/tests/dromaeo/cssquery-ext.html) 08:18:44 INFO - PROCESS | 11785 | RSS: Main: 325124096 08:18:44 INFO - PROCESS | 11785 | 08:20:26 INFO - PROCESS | 11785 | ************************* 08:20:26 INFO - PROCESS | 11785 | A coding exception was thrown and uncaught in a Task. 08:20:26 INFO - PROCESS | 11785 | 08:20:26 ERROR - PROCESS | 11785 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:20:26 INFO - PROCESS | 11785 | Full stack: 08:20:26 INFO - PROCESS | 11785 | ************************* 08:21:47 INFO - PROCESS | 11785 | Cycle 1(1): loaded http://localhost:46806/tests/dromaeo/cssquery-ext.html (next: http://localhost:46806/tests/dromaeo/cssquery-jquery.html) 08:21:48 INFO - PROCESS | 11785 | RSS: Main: 241475584 08:21:48 INFO - PROCESS | 11785 | 08:24:50 INFO - PROCESS | 11785 | Cycle 1(1): loaded http://localhost:46806/tests/dromaeo/cssquery-jquery.html (next: http://localhost:46806/tests/dromaeo/cssquery-mootools.html) 08:24:51 INFO - PROCESS | 11785 | RSS: Main: 182927360 08:24:51 INFO - PROCESS | 11785 | 08:27:53 INFO - PROCESS | 11785 | Cycle 1(1): loaded http://localhost:46806/tests/dromaeo/cssquery-mootools.html (next: http://localhost:46806/tests/dromaeo/cssquery-prototype.html) 08:27:54 INFO - PROCESS | 11785 | RSS: Main: 210989056 08:27:54 INFO - PROCESS | 11785 | 08:30:57 INFO - PROCESS | 11785 | Cycle 1(1): loaded http://localhost:46806/tests/dromaeo/cssquery-prototype.html (next: http://localhost:46806/tests/dromaeo/cssquery-yui.html) 08:30:58 INFO - PROCESS | 11785 | RSS: Main: 188628992 08:30:58 INFO - PROCESS | 11785 | 08:34:01 INFO - PROCESS | 11785 | Cycle 1(1): loaded http://localhost:46806/tests/dromaeo/cssquery-yui.html (next: http://localhost:46806/tests/dromaeo/cssquery-dojo.html) 08:34:01 INFO - PROCESS | 11785 | RSS: Main: 277635072 08:34:01 INFO - PROCESS | 11785 | 08:34:01 INFO - PROCESS | 11785 | __start_tp_report 08:34:01 INFO - PROCESS | 11785 | _x_x_mozilla_page_load 08:34:01 INFO - PROCESS | 11785 | _x_x_mozilla_page_load_details 08:34:01 INFO - PROCESS | 11785 | |i|pagename|runs| 08:34:01 INFO - PROCESS | 11785 | |0;dojo.html;2609.843409395436;2615.5422801009818;2647.0206023771207;2661.1351310823975;2667.759901608856;4800.687955282913;4802.327674125625;4905.239687848385;5001.824936127241;5006.774695138718;4942.654014219006;4944.480829512903;4975.776090075946;5009;5046.21783623539;4504.8198072077075;4547.590716835484;4553.658475614326;4565.1098035883015;4587.747673877935;4596.21864283071;4634.003689206803;4647.60495357895;4648.883777905546;4656.348111264426;4403.955960440387;4418.29307310832;4494.303382975644;4499.6850220484575;4563.771811409416;4487.753173575452;4505.594496495331;4508.053308805155;4512.932306015412;4514.435695538058;4473.306637471197;4484.080763443486;4490.3488994096;4496.078303947683;4498.527654596253;4845.466998630148;4878.073166098466;4889.3643826302705;4901.607871370282;4910.7299098549565;5274.683518988873;5304.496072873071;5316.255724198615;5323.361196656426;5329.25390445338;5399.271098401744;5399.352077750695;5419.783208671648;5448.128299472105;5459.972700136474;4964.950350496521;5010.599152067863;5012.122878496249;5012.1479348510475;5025.095482813055;5265;5286.550643195372;5498.285222920995;5500.147477141049;5503.2020357048;5139.100657385017;5150.27896094547;5152.355955505562;5153.974230128825;5156.535911767959;5242.213667949762;5266.710330931835;5282.867928301823;5287.20691896211;5287.524122828964;5268.078086334876;5277.182036784305;5306.204069389622;5322.520973112439;5323.813666521653;5256.526912577886;5264.9736751315995;5266.078436273637;5276.129438642658;5319.441458646864;4385.188740083095;4412.139632771578;4504.324351347324;4504.594586487232;4518.661100417482;3836.07934095815;3856.6914646828186;3857.324968130566;3885.9611403886165;3909.4917660703927;4623.86128416148;4659.044895796354;4660.813567457264;4663.650226232979;4670.136024835417;5344.599155063386;5393.325834270716;5399.892002159935;5400.675959442446;5437.4562543745305;4608.28571571407;4619.330197121399;4620.145273124483;4623.491415944243;4665.253559430543;4662.930056049162;4706.987997580537;4763.833265835679;4775.5224477551965;4863.294822250754;4932.112219800327;4933.605311575137;4934.925976110289;4937.530934561211;4938.777755001105;5383.946160538501;5397.406285308692;5437.510624043855;5441.891162176814;5458.808941687022;4955.182394904945;4998.950010499994;5013.448520662797;5025.773840177128;5060.291559181791;5131.897362052813;5157.7679004444135;5229.790808367623;5301.151815709468;5350;5290.047791397432;5292.576593872558;5297.046531624344;5297.258383826191;5298.576113910955;5111.1311077117725;5134.717590532557;5147.58819294448;5148.948510514847;5204.245384419162;5002.124628190125;5021.1213037717525;5104.259882316969;5117;5204.34945631796;4952;5028.094942910165;5047.444781074152;5052.1663925451885;5059.114654935298;5076.82231121909;5088.567471764942;5106.387233532;5130.589552835839;5133.845984620468;5125;5137.51193636604;5147.459516750687;5176.223566465061;5196.896062078662 08:34:01 INFO - PROCESS | 11785 | |1;ext.html;696.3941371007223;715.7924201981425;730.8026832755156;742.8848528478081;744.8547533231018;35062.82468587656;35487.82256088722;35666.46500302491;35783.4632480513;40131;37104.44343334852;37432;37443.81278093606;37474.4378834317;37494.43758343627;6810.387065164135;6905.551139175963;7130.607816570074;7232.674529646179;7247.601381923992;8609.95695021524;8759.299256059532;8804.823903521925;8806.911930880673;8996.820063598723;8613.870791938127;8636.222739953402;8651.783705407352;8663.480191188517;8832.249258813008;8569.185927336894;8583.313334933191;8585.141485851427;8587;8601.741947741577;9119;9122.863157052583;9127.634894604207;9143.862842057375;9161.129692679251;34326;34427.82786086079;34553;34618;34727;3359.6472370401;3363.8486268117995;3372.2243883906594;3400;3429;22492.437689057904;22745.886270568706;23691.28926132219;23820.047198112054;23884.880575597184;3056.908292751221;3073.707997740211;3197.904062878117;3268.1339445047083;3269.084656296217;144233;145069;145232.99999999895;146035;146144;35433.29133417317;36004.81997590048;38776.22447551033;38938.80530597329;42528.787356063025;42025.369619455734;46532.53467465282;46694;46834.76582617065;46889;10271.075603195748;10403;12119.697007574881;12162.209456385306;12261.203021803554;8861.158189971942;8979;9182.403143795633;9218.492982886006;9238.491882946502;12914.225146491053;12947.287899165636;13012.934935325453;13033.47866085346;13077.803832942513;5105.617078719111;5117.616178786606;5173.430922598511;5206.687598744087;5263.973680131575;976.9609215631295;981.097390400833;992.2954702161546;1009.5911155981839;1017.699778565325;21664.133434662752;21679.34961951144;21749.13003479875;21853.344399668036;21922.89038554829;1067.2849191042021;1083.3987137138806;1085.7285678580356;1092.3391348234363;1093.557109370706;11128.833067503994;11630.709232269091;11657.533698652129;11744.58893938708;11747.236429632047;240848;242195;242942;243300;243336;42436.363454548205;42911.35632965508;42967.14065718668;42972.355414668804;42996;1185.9589528610863;1225.7977433723513;1233.975320493585;1234.8147777833217;1236.8082947143207;20255.4936126598;20311.79688203099;21424;21442.57114857663;21618.459538511663;35207.11982200466;35427.46858797069;35431.468527971585;35440.822795885855;35479.11302217362;218833;219646;220283;327583;332160;25436.364090897874;30374.696253037186;30602.540961886036;30987.91542296009;31140.532892006184;33047.66952330446;33329.18345293343;33639.32721345608;34331.313373731886;34331.31337373288;28412.43175136527;28609.713902860705;28940.710592894644;29158.56262156112;29237.85381073081;28304.5941095001;28353.29116772097;28567.714322856504;29065.12804615865;29279.56080658749;29178.270543236587;29259.122226333246;29376.11871643854;29682.406351873273;33052.04219367114;25948;27346.855111662415;28494.57258141088;28803;32287.192820179684;23134.305970820904;23482.412939676644;23644.29067127989;23716.52566948686;23750 08:34:01 INFO - PROCESS | 11785 | |2;jquery.html;375.06234413965086;395.85551273785074;397.41381462343037;416.97289676171044;424.6305714028795;11800.645980620573;13627.931860340697;13915.58253252404;19314.130864111114;19491;18916.81083189168;19360.903195484003;19875.801241987574;20311.49221269469;20392.184312627476;4913.82801601944;5785.681787501686;6014.8195554133445;6043.063325184604;6055.424734650202;5088.211327244265;5864.4135586441225;5904.439078287556;5912.320083190445;5914.852128696774;5906.173135760997;5908.025175846002;5909.793157239497;5912.379200183962;6693.196816382041;6993.720251189946;7104.573725576482;7105.57366558003;7110.182329032175;7111.502194846363;6720.462363010947;6961.65191740411;7003.15962084548;7009.08881845362;7020.438364930793;23807.285781426584;23964.64053039206;24225;24338.148164814324;24390.146344878023;2337.4506990857135;2404.4349577849193;2406.2660888429023;2440.8535487870786;2483.726790053093;14670.706585868329;14864.256787160706;14886.255687215596;14986;15797.60505987348;1766.752654628353;1838.7496502378378;1842.1157844234842;1853.1938606705992;1874.681304178293;91655;93585.53207233988;94170.52914735382;94260;96011;16976.915115424592;17620.383286584907;17642.823571764377;17758.46724598264;18043.639127217382;32233.838830805696;32521.837390812896;32856.34287314241;32932;33143.502847457305;8291.95854020738;8359.707410240613;8681.392302538761;8773.07882672323;8780.297576194016;6622.03980422836;6662.633555154416;6748.763793267212;6901.068355772007;6952.304769523108;8918.331125165638;9069.36751384757;9128;9261.67584134552;9450.52747362629;3500.38904295431;3509.8596056157467;3693.4644476550748;3701.759385639925;3848.8460461581785;754.1515794730927;782.8395178988408;791.4103992525605;812.6830536090929;813.6663967773185;18270.63458730818;19437;19546.511337216398;19627;19940;763.3549650545281;769.5844244108231;778.7741554949115;783.3537331701369;790.5612385126195;9894.604215831287;10785.555433666135;10846.045359632792;10869.836702683016;10878.129749620011;472693;473479;487143;491656;496305;86065;86278;86646;87109;89135.55432222797;1055.1453322808702;1064.595453727594;1088.0370871778532;1103.862017247844;1110.211749657752;15874.539446385366;16391.672166556364;16626.418075367303;16817.327306907588;17101;41010.589894100674;41723;41771;41868.79065604653;42500;53763.19355209753;54162.45837541574;54181;54348;54650.453495464535;7552.697892084255;10282;10378.792424151323;10988.945055274673;11032.613858514913;12354.25874447536;12490.68773280639;12531.18547294423;12578.622641320775;12894.226346419246;11016.50425730828;11041.613543525938;11068.335899846035;11392.202545821712;11563.074954003492;9416;9432.151106400457;9487.146156845916;9555.569999350186;9577;11079.5568177272;11110.222284440011;11145.331280123219;11505.309681419141;11620.128490363426;11409.372484513431;11427.314361138358;11459.255148415326;11474.254173478697;11822.704432388915;11003.559857605926;11033.779324413626;11252.549898003988;11512.94243528777;11542 08:34:01 INFO - PROCESS | 11785 | |3;mootools.html;1303.7848754955432;1421.708549747302;1441.5026815748565;1458.117838707582;1465.8827293816491;7932.484388514743;9363.204127649149;9617.615295388185;9874.456904870229;9902.752431189207;9596.280278979088;9677.080677335642;9680;9692.176165025981;9697.175740062103;1894.5831916978277;1939.1952339779045;1946.8442524598;1947.123794292567;1947.7273181754565;1676.8993860368416;1741.686496430642;1978.3669225847734;2033.3290014295321;2041.397787652646;1985.0868600443814;2002.0590322548378;2008.3874418302412;2010.431863146748;2012.3761633893466;1932.062949469506;1963.980360196394;1982.692682634194;1984.3848406993877;1988.880667159975;1920.1647283431753;1939.5829896572304;1944.1834429539626;1968.1438574220117;1969.4977780665981;9629.518524073768;9724.70825875225;9725.610975560969;9736.367136136128;9740.4642744649;4713;4836.903261934777;4838.201696720037;4844.346013288196;4849.684770489942;2590.9481810363877;2623.22614828626;2650.3506640872915;2676.705562388155;2681.115231973464;993.3841018568462;1006.1648831469862;1008.8284991551454;1048.1667074675652;1056.4928834159646;11957.94021029898;12217.450214740269;12535.18521296122;12602.81095783564;12604.558840440632;3728.7203459740626;3778.6221377862544;3860.452101612922;3862.547282475592;3883.728139030241;9457.10157535033;9488.430694158373;9493.857592136124;9495.43027418357;9520.381175223589;4660.161170989187;4663.953360466419;4664.766761661904;4666.32338310943;4667.183242932473;4298.763568003727;4320.848770293024;4378.387025816388;4396.120775844844;4472.686911916199;3208;3213.855376508063;3275.1157187559224;3297.7856439331367;3299.043277449513;875.1336177184669;877.5305211711703;880.2737741363272;889.755317287751;894.1728900766765;619.3434958943534;632.6931438252444;633.8954072578065;648.7859006527834;655.7475371981726;5376.327959005124;5446.7276636168035;5453.836384908459;5484.7531861066345;5804.970975145097;844.3118858130726;862.7368652560904;875.9649614015368;881.5548148185254;883.6023789294843;3464.7401444891734;3470.410030294856;3493.5807703075793;3533.2050288685355;3592.946105808415;11523.07815374768;11910.235905637814;12028.518859245532;12111.818322725167;12190.146689731633;11658.766824663458;12014.939925300318;12023.819642705366;12032.27806331623;12034.699132521757;8692.087330830298;8857.557122143997;8877.644894204288;8879.334049946408;8890.688825891191;5468.808591699271;5520.861978450571;5538.390777014606;5591.776328946797;5711.771529138954;10559.419231942009;10569.418681972566;10594.735131621772;10737.731556711145;10768;10446;10889.782204356026;10919.126469882549;11186.944065279948;11199.21605487608;7198.5680859148615;7392.223816499405;7696.422768292512;7893.486923349964;8144.511329320259;8912.153345432174;9421.057894210524;9427.434353938786;9429.905700942903;9461.621535138793;8192.262696357357;8229.094799571923;8243.711470098518;8342.374321925758;8366.121557236402;8018.278354948083;8027.799305017421;8114.066882308374;8117.10711821711;8142.592870356577;7093.609851458013;7263.237360077116;7265.200827909031;7266.745663901738;7277.38142257914;4925.408950925912;4976.427710813303;5019.347484826949;5056.342675452168;5084.51697088776;5062.215356619583;5133.8716532087;5242.108841497031;5249;5280.102382594891 08:34:01 INFO - PROCESS | 11785 | |4;prototype.html;339.3840180073167;341.9247765491591;351.3727995527983;357.8658003248782;365.7787038841503;4769.856904292868;4774.713517188971;4776.349126234947;4793.082766893244;4807.8798030049265;4516.548345165482;4612.723236605806;4651.674382793198;4674.11062061802;4714.292856071591;3918.490596222487;3931.7640941543455;3935.9999999999927;3938.5076865391825;3940.152867133566;3907.5115610548683;3933.9016524586973;3975.82108805103;3978.2242462719782;3982.4026396040535;3763.7929913854728;3939.9803000984957;3967.761934283938;3990.902501811996;3991.44119823225;3917;3918.784466854322;3934.822932967995;3943.1325108475944;3943.8422463101583;3631.6186800385844;3644.9817750911343;3649.94525082124;3659.2864391443677;3687.7418580699364;4606.60843828275;4610.147122782296;4615.8615241542475;4621.976890115561;4647.5135802345585;4500.0074950158105;4545.36364908913;4694.2723877799;4722.929156062662;4799.3760811094335;4969.975150124226;4983.875403114915;4999.875003124915;5011.498850114996;5026.064964988469;4363.912721745579;4381.671374646914;4408.3248365621175;4415.20526305265;4419.690621656486;5058.116873382173;5190.455002224788;5244.8688782780355;5265.86835329116;5340.198970154469;4458.238995596721;4479.888002799956;4486.528914463999;4555.316702494586;4622.19111655459;4592.219322715079;4600.401947746772;4637.976810115928;4651.2557990721325;4675.275332323496;4419.779011049434;4704.788284527204;4713.397444868761;4732.219183834629;4739.336492890998;4912.38595175603;4933.45731969483;4944.826931057468;4948.282499037619;4949.529794669573;1584.4375246787456;1588.6743217640355;1592.4426450742149;1592.7610858371106;1598.448535255335;1245.8997245393457;1305.3342795174528;1312.3766211049674;1324.4966912573352;1335.3723749837561;4148.5065376464445;4270.508891477458;4278.0374415756205;4301.677374196947;4312.757366169637;5041.924371134436;5054.014467178865;5063.56948664643;5078.365204349457;5084.9745751271;4238.470191226097;4239.936400953989;4257.574242575718;4325.264705000158;4325.286327755948;2502.712188098392;2655.74770396812;2657.096587160336;2664.200739778059;2669.6529451171614;4737.739424331626;4738.881527961759;4744.197205062123;4765.785539650724;4787.497312782178;4916.328448327586;5029.698218106852;5184.818531351385;5185.0407674579565;5205.713685747244;4610.953890461053;4681.602063824613;4700.2009658358165;4711.646626503095;4735.389967411097;4999.250112483011;5023.4725353838785;5027.446980832033;5044.015227969862;5068.594512438923;4749.525047495223;4867.5862551682085;4878.902421951612;4946.208606622923;4971.9863455300665;4653.162430762495;4654.37165982588;4664.4869064403565;4703.482616912069;4739.886126760278;4452.1763473757455;4474.306482495218;4477.895389167086;4481.395011673382;4510.5340764252405;4719.622430205507;4994.5754610858485;5001.274815151855;5045.502476274268;5075.720835354091;4883.853484395474;4900.754962251945;4906.239532872411;4908.63185261114;4916.778744956414;4847.442544107473;4873.1959226727195;4881.780319885685;4919.262110683426;4925.778339974781;4568.725876447424;4800.639952003684;4822.324874517641;4828.686135401188;4836.469377354621;4926.3842019747535;4941.65408421407;4945.876353091202;4946.3817022872145;4959.256111583291;4765.976170119266;4798.352222449925;4800.591949684316;4815.181419158681;4840.273958906192 08:34:01 INFO - PROCESS | 11785 | |5;yui.html;649.2955143669119;659.9835004124893;673.4645956464611;681.9761308354207;698.8951657251412;12039.879601203986;13049.217046977188;13214.141080829739;13295.335233238347;13296.335183240835;12547.058970577198;12599.181053231534;12749.043821713361;13209.273489958048;13369.997250206225;818.9099199088096;847.1105339393642;847.3602430165216;852.6248450681711;854.090393730678;838.2958315015417;848.9897022543184;857;860.711661593367;863.568215892054;876.8246350729847;878.4246318661255;878.7759121424028;879.2877769007092;880.3573391424264;874.9475031498099;877.1929824561387;879.3361012435635;884.3765145572356;885.3183049052194;652.0447544347506;657.1653999420708;657.9144711187563;661.1075048684286;662.1788981662752;13495.392707328194;13833.377498012613;13861.376238069312;13869.167849928936;14594.343254553465;13644.317784110755;14088.013839031271;14223.146611203361;14336;14345.110189395791;9880.802383952281;9959.80080398388;9961;10206.744831379201;10378.63674771387;3108.4870996285586;3110.0825256549147;3122.9219269518217;3137.607799025122;3166.208447888028;66400.3359966399;66572.3342766571;67058.66470667615;67113.66443167801;69385.30614693838;10955.561777528968;10957.287776294515;10978.890211097947;11062.834057489144;11619.535218591162;22069.668954965688;22080.668789968164;22091.226807061677;22104.33686989393;22111.226107086175;6012.969935150296;6021.187139736079;6171.938280617136;6260.46786023184;6443.645599491979;3329.217633856042;3469.705075068597;3486.4770284457536;3511.0871173495075;3512.8946131616094;2596.9870150649126;2635.5387807133675;2667.733226677317;2669.906553270665;2678.5178667839978;444.613186527723;445.1853108810868;449.0905915521031;453.6302913125792;455.3920516110963;534.8235082422791;549.5548605629454;571.828451464559;580.4775701868352;586.7975548435783;7955.323797477279;8076;8234.970628671415;8257.463264887763;8650.221480066699;518.6218909904317;522.6550476685445;533.9519443250126;553.0239127939191;558.8267637032452;3722.6919310027415;3770.490983717218;3791.279656865187;4029.5366032906004;4689;59283.40716592865;60450;61429;63870.6806465974;64126.38104284395;46116.76941615337;47100.7644961773;48950.510494894595;49585.25622115671;50815.49184508107;44938.55061449343;45300.546994529635;45347;45447.318290225674;47541.762291189014;8452.74641760748;8893;8971.237444817263;9050.818983620422;9072.092790720875;32278.677213227566;33269.33461330712;33969.49045764266;34060.659393405746;35253.29493410169;37835.43246851354;38256.23487530289;38294;39122;39157.412638809874;11412.600558980395;11552.884471155181;11665.533378665097;11671;12110.333931633844;12649.87350126487;12697.55558555446;12766.936165319114;13111.344432778515;13462.596122116352;11865.881341186478;12309.893013599492;12334.444949977093;12457.750844983231;12578.182418142791;11204.439778010903;11209;11402.315861048364;11421.657350279505;11808.645740627795;10905.491736900716;11052.336859788438;11334.319940803578;11366.829497557377;11410.94294528522;9159.450432974043;9333.953330233306;9341;9426.764330891783;9440.19758320523;8543.957280213808;8579.313654907717;8980.550972451481;9126.954365228132;9267.907320926704 08:34:01 INFO - PROCESS | 11785 | __end_tp_report 08:34:01 INFO - PROCESS | 11785 | __start_cc_report 08:34:01 INFO - PROCESS | 11785 | _x_x_mozilla_cycle_collect,2059 08:34:01 INFO - PROCESS | 11785 | __end_cc_report 08:34:01 INFO - PROCESS | 11785 | __startTimestamp1489163641534__endTimestamp 08:34:01 INFO - PROCESS | 11785 | 08:34:01 INFO - PROCESS | 11785 | ------- Summary: start ------- 08:34:01 INFO - PROCESS | 11785 | Number of tests: 6 08:34:01 INFO - PROCESS | 11785 | 08:34:01 INFO - PROCESS | 11785 | [#0] dojo.html Cycles:165 Average:4891.45 Median:5013.45 stddev:538.61 (10.7%) stddev-sans-first:509.66 08:34:01 INFO - PROCESS | 11785 | Values: 2609.8 2615.5 2647.0 2661.1 2667.8 4800.7 4802.3 4905.2 5001.8 5006.8 4942.7 4944.5 4975.8 5009.0 5046.2 4504.8 4547.6 4553.7 4565.1 4587.7 4596.2 4634.0 4647.6 4648.9 4656.3 4404.0 4418.3 4494.3 4499.7 4563.8 4487.8 4505.6 4508.1 4512.9 4514.4 4473.3 4484.1 4490.3 4496.1 4498.5 4845.5 4878.1 4889.4 4901.6 4910.7 5274.7 5304.5 5316.3 5323.4 5329.3 5399.3 5399.4 5419.8 5448.1 5460.0 4965.0 5010.6 5012.1 5012.1 5025.1 5265.0 5286.6 5498.3 5500.1 5503.2 5139.1 5150.3 5152.4 5154.0 5156.5 5242.2 5266.7 5282.9 5287.2 5287.5 5268.1 5277.2 5306.2 5322.5 5323.8 5256.5 5265.0 5266.1 5276.1 5319.4 4385.2 4412.1 4504.3 4504.6 4518.7 3836.1 3856.7 3857.3 3886.0 3909.5 4623.9 4659.0 4660.8 4663.7 4670.1 5344.6 5393.3 5399.9 5400.7 5437.5 4608.3 4619.3 4620.1 4623.5 4665.3 4662.9 4707.0 4763.8 4775.5 4863.3 4932.1 4933.6 4934.9 4937.5 4938.8 5383.9 5397.4 5437.5 5441.9 5458.8 4955.2 4999.0 5013.4 5025.8 5060.3 5131.9 5157.8 5229.8 5301.2 5350.0 5290.0 5292.6 5297.0 5297.3 5298.6 5111.1 5134.7 5147.6 5148.9 5204.2 5002.1 5021.1 5104.3 5117.0 5204.3 4952.0 5028.1 5047.4 5052.2 5059.1 5076.8 5088.6 5106.4 5130.6 5133.8 5125.0 5137.5 5147.5 5176.2 5196.9 08:34:01 INFO - PROCESS | 11785 | 08:34:01 INFO - PROCESS | 11785 | [#1] ext.html Cycles:180 Average:35967.00 Median:33049.86 stddev:59037.62 (178.6%) stddev-sans-first:59143.84 08:34:01 INFO - PROCESS | 11785 | Values: 696.4 715.8 730.8 742.9 744.9 35062.8 35487.8 35666.5 35783.5 40131.0 37104.4 37432.0 37443.8 37474.4 37494.4 6810.4 6905.6 7130.6 7232.7 7247.6 8610.0 8759.3 8804.8 8806.9 8996.8 8613.9 8636.2 8651.8 8663.5 8832.2 8569.2 8583.3 8585.1 8587.0 8601.7 9119.0 9122.9 9127.6 9143.9 9161.1 34326.0 34427.8 34553.0 34618.0 34727.0 3359.6 3363.8 3372.2 3400.0 3429.0 22492.4 22745.9 23691.3 23820.0 23884.9 3056.9 3073.7 3197.9 3268.1 3269.1 144233.0 145069.0 145233.0 146035.0 146144.0 35433.3 36004.8 38776.2 38938.8 42528.8 42025.4 46532.5 46694.0 46834.8 46889.0 10271.1 10403.0 12119.7 12162.2 12261.2 8861.2 8979.0 9182.4 9218.5 9238.5 12914.2 12947.3 13012.9 13033.5 13077.8 5105.6 5117.6 5173.4 5206.7 5264.0 977.0 981.1 992.3 1009.6 1017.7 21664.1 21679.3 21749.1 21853.3 21922.9 1067.3 1083.4 1085.7 1092.3 1093.6 11128.8 11630.7 11657.5 11744.6 11747.2 240848.0 242195.0 242942.0 243300.0 243336.0 42436.4 42911.4 42967.1 42972.4 42996.0 1186.0 1225.8 1234.0 1234.8 1236.8 20255.5 20311.8 21424.0 21442.6 21618.5 35207.1 35427.5 35431.5 35440.8 35479.1 218833.0 219646.0 220283.0 327583.0 332160.0 25436.4 30374.7 30602.5 30987.9 31140.5 33047.7 33329.2 33639.3 34331.3 34331.3 28412.4 28609.7 28940.7 29158.6 29237.9 28304.6 28353.3 28567.7 29065.1 29279.6 29178.3 29259.1 29376.1 29682.4 33052.0 25948.0 27346.9 28494.6 28803.0 32287.2 23134.3 23482.4 23644.3 23716.5 23750.0 08:34:01 INFO - PROCESS | 11785 | 08:34:01 INFO - PROCESS | 11785 | [#2] jquery.html Cycles:180 Average:29922.87 Median:3697.61 stddev:79864.69 (2159.9%) stddev-sans-first:80057.92 08:34:01 INFO - PROCESS | 11785 | Values: 375.1 395.9 397.4 417.0 424.6 11800.6 13627.9 13915.6 19314.1 19491.0 18916.8 19360.9 19875.8 20311.5 20392.2 4913.8 5785.7 6014.8 6043.1 6055.4 5088.2 5864.4 5904.4 5912.3 5914.9 5906.2 5908.0 5909.8 5912.4 6693.2 6993.7 7104.6 7105.6 7110.2 7111.5 6720.5 6961.7 7003.2 7009.1 7020.4 23807.3 23964.6 24225.0 24338.1 24390.1 2337.5 2404.4 2406.3 2440.9 2483.7 14670.7 14864.3 14886.3 14986.0 15797.6 1766.8 1838.7 1842.1 1853.2 1874.7 91655.0 93585.5 94170.5 94260.0 96011.0 16976.9 17620.4 17642.8 17758.5 18043.6 32233.8 32521.8 32856.3 32932.0 33143.5 8292.0 8359.7 8681.4 8773.1 8780.3 6622.0 6662.6 6748.8 6901.1 6952.3 8918.3 9069.4 9128.0 9261.7 9450.5 3500.4 3509.9 3693.5 3701.8 3848.8 754.2 782.8 791.4 812.7 813.7 18270.6 19437.0 19546.5 19627.0 19940.0 763.4 769.6 778.8 783.4 790.6 9894.6 10785.6 10846.0 10869.8 10878.1 472693.0 473479.0 487143.0 491656.0 496305.0 86065.0 86278.0 86646.0 87109.0 89135.6 1055.1 1064.6 1088.0 1103.9 1110.2 15874.5 16391.7 16626.4 16817.3 17101.0 41010.6 41723.0 41771.0 41868.8 42500.0 53763.2 54162.5 54181.0 54348.0 54650.5 7552.7 10282.0 10378.8 10988.9 11032.6 12354.3 12490.7 12531.2 12578.6 12894.2 11016.5 11041.6 11068.3 11392.2 11563.1 9416.0 9432.2 9487.1 9555.6 9577.0 11079.6 11110.2 11145.3 11505.3 11620.1 11409.4 11427.3 11459.3 11474.3 11822.7 11003.6 11033.8 11252.5 11512.9 11542.0 08:34:01 INFO - PROCESS | 11785 | 08:34:01 INFO - PROCESS | 11785 | [#3] mootools.html Cycles:180 Average:5790.55 Median:4837.55 stddev:3688.56 (76.2%) stddev-sans-first:3683.50 08:34:01 INFO - PROCESS | 11785 | Values: 1303.8 1421.7 1441.5 1458.1 1465.9 7932.5 9363.2 9617.6 9874.5 9902.8 9596.3 9677.1 9680.0 9692.2 9697.2 1894.6 1939.2 1946.8 1947.1 1947.7 1676.9 1741.7 1978.4 2033.3 2041.4 1985.1 2002.1 2008.4 2010.4 2012.4 1932.1 1964.0 1982.7 1984.4 1988.9 1920.2 1939.6 1944.2 1968.1 1969.5 9629.5 9724.7 9725.6 9736.4 9740.5 4713.0 4836.9 4838.2 4844.3 4849.7 2590.9 2623.2 2650.4 2676.7 2681.1 993.4 1006.2 1008.8 1048.2 1056.5 11957.9 12217.5 12535.2 12602.8 12604.6 3728.7 3778.6 3860.5 3862.5 3883.7 9457.1 9488.4 9493.9 9495.4 9520.4 4660.2 4664.0 4664.8 4666.3 4667.2 4298.8 4320.8 4378.4 4396.1 4472.7 3208.0 3213.9 3275.1 3297.8 3299.0 875.1 877.5 880.3 889.8 894.2 619.3 632.7 633.9 648.8 655.7 5376.3 5446.7 5453.8 5484.8 5805.0 844.3 862.7 876.0 881.6 883.6 3464.7 3470.4 3493.6 3533.2 3592.9 11523.1 11910.2 12028.5 12111.8 12190.1 11658.8 12014.9 12023.8 12032.3 12034.7 8692.1 8857.6 8877.6 8879.3 8890.7 5468.8 5520.9 5538.4 5591.8 5711.8 10559.4 10569.4 10594.7 10737.7 10768.0 10446.0 10889.8 10919.1 11186.9 11199.2 7198.6 7392.2 7696.4 7893.5 8144.5 8912.2 9421.1 9427.4 9429.9 9461.6 8192.3 8229.1 8243.7 8342.4 8366.1 8018.3 8027.8 8114.1 8117.1 8142.6 7093.6 7263.2 7265.2 7266.7 7277.4 4925.4 4976.4 5019.3 5056.3 5084.5 5062.2 5133.9 5242.1 5249.0 5280.1 08:34:01 INFO - PROCESS | 11785 | 08:34:01 INFO - PROCESS | 11785 | [#4] prototype.html Cycles:180 Average:4273.60 Median:4674.69 stddev:1096.34 (23.5%) stddev-sans-first:1058.91 08:34:01 INFO - PROCESS | 11785 | Values: 339.4 341.9 351.4 357.9 365.8 4769.9 4774.7 4776.3 4793.1 4807.9 4516.5 4612.7 4651.7 4674.1 4714.3 3918.5 3931.8 3936.0 3938.5 3940.2 3907.5 3933.9 3975.8 3978.2 3982.4 3763.8 3940.0 3967.8 3990.9 3991.4 3917.0 3918.8 3934.8 3943.1 3943.8 3631.6 3645.0 3649.9 3659.3 3687.7 4606.6 4610.1 4615.9 4622.0 4647.5 4500.0 4545.4 4694.3 4722.9 4799.4 4970.0 4983.9 4999.9 5011.5 5026.1 4363.9 4381.7 4408.3 4415.2 4419.7 5058.1 5190.5 5244.9 5265.9 5340.2 4458.2 4479.9 4486.5 4555.3 4622.2 4592.2 4600.4 4638.0 4651.3 4675.3 4419.8 4704.8 4713.4 4732.2 4739.3 4912.4 4933.5 4944.8 4948.3 4949.5 1584.4 1588.7 1592.4 1592.8 1598.4 1245.9 1305.3 1312.4 1324.5 1335.4 4148.5 4270.5 4278.0 4301.7 4312.8 5041.9 5054.0 5063.6 5078.4 5085.0 4238.5 4239.9 4257.6 4325.3 4325.3 2502.7 2655.7 2657.1 2664.2 2669.7 4737.7 4738.9 4744.2 4765.8 4787.5 4916.3 5029.7 5184.8 5185.0 5205.7 4611.0 4681.6 4700.2 4711.6 4735.4 4999.3 5023.5 5027.4 5044.0 5068.6 4749.5 4867.6 4878.9 4946.2 4972.0 4653.2 4654.4 4664.5 4703.5 4739.9 4452.2 4474.3 4477.9 4481.4 4510.5 4719.6 4994.6 5001.3 5045.5 5075.7 4883.9 4900.8 4906.2 4908.6 4916.8 4847.4 4873.2 4881.8 4919.3 4925.8 4568.7 4800.6 4822.3 4828.7 4836.5 4926.4 4941.7 4945.9 4946.4 4959.3 4766.0 4798.4 4800.6 4815.2 4840.3 08:34:01 INFO - PROCESS | 11785 | 08:34:01 INFO - PROCESS | 11785 | [#5] yui.html Cycles:180 Average:14265.54 Median:22877.09 stddev:17256.10 (75.4%) stddev-sans-first:17274.21 08:34:01 INFO - PROCESS | 11785 | Values: 649.3 660.0 673.5 682.0 698.9 12039.9 13049.2 13214.1 13295.3 13296.3 12547.1 12599.2 12749.0 13209.3 13370.0 818.9 847.1 847.4 852.6 854.1 838.3 849.0 857.0 860.7 863.6 876.8 878.4 878.8 879.3 880.4 874.9 877.2 879.3 884.4 885.3 652.0 657.2 657.9 661.1 662.2 13495.4 13833.4 13861.4 13869.2 14594.3 13644.3 14088.0 14223.1 14336.0 14345.1 9880.8 9959.8 9961.0 10206.7 10378.6 3108.5 3110.1 3122.9 3137.6 3166.2 66400.3 66572.3 67058.7 67113.7 69385.3 10955.6 10957.3 10978.9 11062.8 11619.5 22069.7 22080.7 22091.2 22104.3 22111.2 6013.0 6021.2 6171.9 6260.5 6443.6 3329.2 3469.7 3486.5 3511.1 3512.9 2597.0 2635.5 2667.7 2669.9 2678.5 444.6 445.2 449.1 453.6 455.4 534.8 549.6 571.8 580.5 586.8 7955.3 8076.0 8235.0 8257.5 8650.2 518.6 522.7 534.0 553.0 558.8 3722.7 3770.5 3791.3 4029.5 4689.0 59283.4 60450.0 61429.0 63870.7 64126.4 46116.8 47100.8 48950.5 49585.3 50815.5 44938.6 45300.5 45347.0 45447.3 47541.8 8452.7 8893.0 8971.2 9050.8 9072.1 32278.7 33269.3 33969.5 34060.7 35253.3 37835.4 38256.2 38294.0 39122.0 39157.4 11412.6 11552.9 11665.5 11671.0 12110.3 12649.9 12697.6 12766.9 13111.3 13462.6 11865.9 12309.9 12334.4 12457.8 12578.2 11204.4 11209.0 11402.3 11421.7 11808.6 10905.5 11052.3 11334.3 11366.8 11410.9 9159.5 9334.0 9341.0 9426.8 9440.2 8544.0 8579.3 8980.6 9127.0 9267.9 08:34:01 INFO - PROCESS | 11785 | -------- Summary: end -------- 08:34:01 INFO - PROCESS | 11785 | 08:34:02 INFO - TEST-INFO | 11785: exit 0 08:34:02 INFO - TEST-OK | dromaeo_css | took 1124295ms 08:34:02 INFO - TEST-START | kraken 08:34:02 INFO - operating with platform_type : linux_ 08:34:02 INFO - Initialising browser for kraken test... 08:34:02 INFO - TEST-INFO | started process 12115 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpegCEnd/profile http://localhost:46806/getInfo.html) 08:34:06 INFO - PROCESS | 12115 | __metrics Screen width/height:1600/1200 08:34:06 INFO - PROCESS | 12115 | colorDepth:24 08:34:06 INFO - PROCESS | 12115 | Browser inner width/height: 1024/697 08:34:06 INFO - PROCESS | 12115 | __metrics 08:34:08 INFO - PROCESS | 12115 | 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" 08:34:08 INFO - PROCESS | 12115 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:34:09 INFO - TEST-INFO | 12115: exit 0 08:34:09 INFO - Browser initialized. 08:34:09 INFO - Running cycle 1/1 for kraken test... 08:34:09 INFO - TEST-INFO | started process 12206 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpegCEnd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:34:21 INFO - PROCESS | 12206 | RSS: Main: 148516864 08:34:21 INFO - PROCESS | 12206 | 08:34:24 INFO - PROCESS | 12206 | Cycle 1(1): loaded http://localhost:46806/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:46806/tests/kraken/driver.html?testName=audio-beat-detection) 08:34:25 INFO - PROCESS | 12206 | RSS: Main: 202702848 08:34:25 INFO - PROCESS | 12206 | 08:34:27 INFO - PROCESS | 12206 | Cycle 1(1): loaded http://localhost:46806/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:46806/tests/kraken/driver.html?testName=audio-dft) 08:34:28 INFO - PROCESS | 12206 | RSS: Main: 182538240 08:34:28 INFO - PROCESS | 12206 | 08:34:31 INFO - PROCESS | 12206 | Cycle 1(1): loaded http://localhost:46806/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:46806/tests/kraken/driver.html?testName=audio-fft) 08:34:32 INFO - PROCESS | 12206 | RSS: Main: 265723904 08:34:32 INFO - PROCESS | 12206 | 08:34:34 INFO - PROCESS | 12206 | Cycle 1(1): loaded http://localhost:46806/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:46806/tests/kraken/driver.html?testName=audio-oscillator) 08:34:34 INFO - PROCESS | 12206 | RSS: Main: 176201728 08:34:34 INFO - PROCESS | 12206 | 08:34:37 INFO - PROCESS | 12206 | Cycle 1(1): loaded http://localhost:46806/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:46806/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:34:37 INFO - PROCESS | 12206 | RSS: Main: 179572736 08:34:37 INFO - PROCESS | 12206 | 08:34:40 INFO - PROCESS | 12206 | Cycle 1(1): loaded http://localhost:46806/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:46806/tests/kraken/driver.html?testName=imaging-darkroom) 08:34:41 INFO - PROCESS | 12206 | RSS: Main: 219340800 08:34:41 INFO - PROCESS | 12206 | 08:34:45 INFO - PROCESS | 12206 | Cycle 1(1): loaded http://localhost:46806/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:46806/tests/kraken/driver.html?testName=imaging-desaturate) 08:34:45 INFO - PROCESS | 12206 | RSS: Main: 214138880 08:34:45 INFO - PROCESS | 12206 | 08:34:48 INFO - PROCESS | 12206 | Cycle 1(1): loaded http://localhost:46806/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:46806/tests/kraken/driver.html?testName=json-parse-financial) 08:34:49 INFO - PROCESS | 12206 | RSS: Main: 215998464 08:34:49 INFO - PROCESS | 12206 | 08:34:50 INFO - PROCESS | 12206 | Cycle 1(1): loaded http://localhost:46806/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:46806/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:34:51 INFO - PROCESS | 12206 | RSS: Main: 179511296 08:34:51 INFO - PROCESS | 12206 | 08:34:53 INFO - PROCESS | 12206 | Cycle 1(1): loaded http://localhost:46806/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:46806/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:34:53 INFO - PROCESS | 12206 | RSS: Main: 187572224 08:34:53 INFO - PROCESS | 12206 | 08:34:56 INFO - PROCESS | 12206 | Cycle 1(1): loaded http://localhost:46806/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:46806/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:34:56 INFO - PROCESS | 12206 | RSS: Main: 195756032 08:34:56 INFO - PROCESS | 12206 | 08:34:59 INFO - PROCESS | 12206 | Cycle 1(1): loaded http://localhost:46806/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:46806/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:35:00 INFO - PROCESS | 12206 | RSS: Main: 205602816 08:35:00 INFO - PROCESS | 12206 | 08:35:03 INFO - PROCESS | 12206 | Cycle 1(1): loaded http://localhost:46806/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:46806/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:35:04 INFO - PROCESS | 12206 | RSS: Main: 201216000 08:35:04 INFO - PROCESS | 12206 | 08:35:05 INFO - PROCESS | 12206 | Cycle 1(1): loaded http://localhost:46806/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:46806/tests/kraken/driver.html?testName=ai-astar) 08:35:06 INFO - PROCESS | 12206 | RSS: Main: 252768256 08:35:06 INFO - PROCESS | 12206 | 08:35:06 INFO - PROCESS | 12206 | __start_tp_report 08:35:06 INFO - PROCESS | 12206 | _x_x_mozilla_page_load 08:35:06 INFO - PROCESS | 12206 | _x_x_mozilla_page_load_details 08:35:06 INFO - PROCESS | 12206 | |i|pagename|runs| 08:35:06 INFO - PROCESS | 12206 | |0;ai-astar;110;117;118;117;118;118;116;117;118;118 08:35:06 INFO - PROCESS | 12206 | |1;audio-beat-detection;149;128;130;164;128;125;124;122;151;125 08:35:06 INFO - PROCESS | 12206 | |2;audio-dft;162;162;163;163;162;162;162;163;164;164 08:35:06 INFO - PROCESS | 12206 | |3;audio-fft;75;76;77;119;76;75;76;76;104;77 08:35:06 INFO - PROCESS | 12206 | |4;audio-oscillator;85;84;109;84;84;84;108;85;84;121 08:35:06 INFO - PROCESS | 12206 | |5;imaging-gaussian-blur;114;114;114;114;113;113;113;113;113;113 08:35:06 INFO - PROCESS | 12206 | |6;imaging-darkroom;149;150;150;148;149;149;149;149;152;151 08:35:06 INFO - PROCESS | 12206 | |7;imaging-desaturate;94;94;95;94;94;95;94;94;94;94 08:35:06 INFO - PROCESS | 12206 | |8;json-parse-financial;65;66;67;67;68;67;67;67;66;67 08:35:06 INFO - PROCESS | 12206 | |9;json-stringify-tinderbox;55;55;55;56;55;55;56;55;56;55 08:35:06 INFO - PROCESS | 12206 | |10;stanford-crypto-aes;87;87;86;86;86;95;92;93;86;94 08:35:06 INFO - PROCESS | 12206 | |11;stanford-crypto-ccm;137;135;137;134;132;134;133;151;175;160 08:35:06 INFO - PROCESS | 12206 | |12;stanford-crypto-pbkdf2;182;184;191;179;178;184;184;180;182;179 08:35:06 INFO - PROCESS | 12206 | |13;stanford-crypto-sha256-iterative;68;70;68;67;72;68;65;83;66;67 08:35:06 INFO - PROCESS | 12206 | __end_tp_report 08:35:06 INFO - PROCESS | 12206 | __start_cc_report 08:35:06 INFO - PROCESS | 12206 | _x_x_mozilla_cycle_collect,2035 08:35:06 INFO - PROCESS | 12206 | __end_cc_report 08:35:06 INFO - PROCESS | 12206 | __startTimestamp1489163706166__endTimestamp 08:35:06 INFO - PROCESS | 12206 | 08:35:06 INFO - PROCESS | 12206 | ------- Summary: start ------- 08:35:06 INFO - PROCESS | 12206 | Number of tests: 14 08:35:06 INFO - PROCESS | 12206 | 08:35:06 INFO - PROCESS | 12206 | [#0] ai-astar Cycles:10 Average:116.70 Median:118.00 stddev:2.45 (2.1%) stddev-sans-first:0.73 08:35:06 INFO - PROCESS | 12206 | Values: 110.0 117.0 118.0 117.0 118.0 118.0 116.0 117.0 118.0 118.0 08:35:06 INFO - PROCESS | 12206 | 08:35:06 INFO - PROCESS | 12206 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:129.00 stddev:14.55 (11.3%) stddev-sans-first:14.47 08:35:06 INFO - PROCESS | 12206 | Values: 149.0 128.0 130.0 164.0 128.0 125.0 124.0 122.0 151.0 125.0 08:35:06 INFO - PROCESS | 12206 | 08:35:06 INFO - PROCESS | 12206 | [#2] audio-dft Cycles:10 Average:162.70 Median:163.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 08:35:06 INFO - PROCESS | 12206 | Values: 162.0 162.0 163.0 163.0 162.0 162.0 162.0 163.0 164.0 164.0 08:35:06 INFO - PROCESS | 12206 | 08:35:06 INFO - PROCESS | 12206 | [#3] audio-fft Cycles:10 Average:83.10 Median:76.00 stddev:15.39 (20.3%) stddev-sans-first:16.05 08:35:06 INFO - PROCESS | 12206 | Values: 75.0 76.0 77.0 119.0 76.0 75.0 76.0 76.0 104.0 77.0 08:35:06 INFO - PROCESS | 12206 | 08:35:06 INFO - PROCESS | 12206 | [#4] audio-oscillator Cycles:10 Average:92.80 Median:84.00 stddev:14.13 (16.8%) stddev-sans-first:14.71 08:35:06 INFO - PROCESS | 12206 | Values: 85.0 84.0 109.0 84.0 84.0 84.0 108.0 85.0 84.0 121.0 08:35:06 INFO - PROCESS | 12206 | 08:35:06 INFO - PROCESS | 12206 | [#5] imaging-gaussian-blur Cycles:10 Average:113.40 Median:113.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 08:35:06 INFO - PROCESS | 12206 | Values: 114.0 114.0 114.0 114.0 113.0 113.0 113.0 113.0 113.0 113.0 08:35:06 INFO - PROCESS | 12206 | 08:35:06 INFO - PROCESS | 12206 | [#6] imaging-darkroom Cycles:10 Average:149.60 Median:149.50 stddev:1.17 (0.8%) stddev-sans-first:1.22 08:35:06 INFO - PROCESS | 12206 | Values: 149.0 150.0 150.0 148.0 149.0 149.0 149.0 149.0 152.0 151.0 08:35:06 INFO - PROCESS | 12206 | 08:35:06 INFO - PROCESS | 12206 | [#7] imaging-desaturate Cycles:10 Average:94.20 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:35:06 INFO - PROCESS | 12206 | Values: 94.0 94.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 94.0 08:35:06 INFO - PROCESS | 12206 | 08:35:06 INFO - PROCESS | 12206 | [#8] json-parse-financial Cycles:10 Average:66.70 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.60 08:35:06 INFO - PROCESS | 12206 | Values: 65.0 66.0 67.0 67.0 68.0 67.0 67.0 67.0 66.0 67.0 08:35:06 INFO - PROCESS | 12206 | 08:35:06 INFO - PROCESS | 12206 | [#9] json-stringify-tinderbox Cycles:10 Average:55.30 Median:55.00 stddev:0.48 (0.9%) stddev-sans-first:0.50 08:35:06 INFO - PROCESS | 12206 | Values: 55.0 55.0 55.0 56.0 55.0 55.0 56.0 55.0 56.0 55.0 08:35:06 INFO - PROCESS | 12206 | 08:35:06 INFO - PROCESS | 12206 | [#10] stanford-crypto-aes Cycles:10 Average:89.20 Median:89.50 stddev:3.79 (4.2%) stddev-sans-first:3.94 08:35:06 INFO - PROCESS | 12206 | Values: 87.0 87.0 86.0 86.0 86.0 95.0 92.0 93.0 86.0 94.0 08:35:06 INFO - PROCESS | 12206 | 08:35:06 INFO - PROCESS | 12206 | [#11] stanford-crypto-ccm Cycles:10 Average:142.80 Median:137.00 stddev:14.51 (10.6%) stddev-sans-first:15.24 08:35:06 INFO - PROCESS | 12206 | Values: 137.0 135.0 137.0 134.0 132.0 134.0 133.0 151.0 175.0 160.0 08:35:06 INFO - PROCESS | 12206 | 08:35:06 INFO - PROCESS | 12206 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.30 Median:183.00 stddev:3.80 (2.1%) stddev-sans-first:4.03 08:35:06 INFO - PROCESS | 12206 | Values: 182.0 184.0 191.0 179.0 178.0 184.0 184.0 180.0 182.0 179.0 08:35:06 INFO - PROCESS | 12206 | 08:35:06 INFO - PROCESS | 12206 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:68.00 stddev:5.17 (7.6%) stddev-sans-first:5.46 08:35:06 INFO - PROCESS | 12206 | Values: 68.0 70.0 68.0 67.0 72.0 68.0 65.0 83.0 66.0 67.0 08:35:06 INFO - PROCESS | 12206 | -------- Summary: end -------- 08:35:06 INFO - PROCESS | 12206 | 08:35:07 INFO - TEST-INFO | 12206: exit 0 08:35:07 INFO - TEST-OK | kraken | took 64941ms 08:35:07 INFO - SUITE-END | took 1189s 08:35:07 INFO - Completed test suite (00:19:49) 08:35:07 INFO - javascript benchmark 08:35:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6567.137625325145, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2609.843409395436, 2615.5422801009818, 2647.0206023771207, 2661.1351310823975, 2667.759901608856, 4800.687955282913, 4802.327674125625, 4905.239687848385, 5001.824936127241, 5006.774695138718, 4942.654014219006, 4944.480829512903, 4975.776090075946, 5009.0, 5046.21783623539, 4504.8198072077075, 4547.590716835484, 4553.658475614326, 4565.1098035883015, 4587.747673877935, 4596.21864283071, 4634.003689206803, 4647.60495357895, 4648.883777905546, 4656.348111264426, 4403.955960440387, 4418.29307310832, 4494.303382975644, 4499.6850220484575, 4563.771811409416, 4487.753173575452, 4505.594496495331, 4508.053308805155, 4512.932306015412, 4514.435695538058, 4473.306637471197, 4484.080763443486, 4490.3488994096, 4496.078303947683, 4498.527654596253, 4845.466998630148, 4878.073166098466, 4889.3643826302705, 4901.607871370282, 4910.7299098549565, 5274.683518988873, 5304.496072873071, 5316.255724198615, 5323.361196656426, 5329.25390445338, 5399.271098401744, 5399.352077750695, 5419.783208671648, 5448.128299472105, 5459.972700136474, 4964.950350496521, 5010.599152067863, 5012.122878496249, 5012.1479348510475, 5025.095482813055, 5265.0, 5286.550643195372, 5498.285222920995, 5500.147477141049, 5503.2020357048, 5139.100657385017, 5150.27896094547, 5152.355955505562, 5153.974230128825, 5156.535911767959, 5242.213667949762, 5266.710330931835, 5282.867928301823, 5287.20691896211, 5287.524122828964, 5268.078086334876, 5277.182036784305, 5306.204069389622, 5322.520973112439, 5323.813666521653, 5256.526912577886, 5264.9736751315995, 5266.078436273637, 5276.129438642658, 5319.441458646864, 4385.188740083095, 4412.139632771578, 4504.324351347324, 4504.594586487232, 4518.661100417482, 3836.07934095815, 3856.6914646828186, 3857.324968130566, 3885.9611403886165, 3909.4917660703927, 4623.86128416148, 4659.044895796354, 4660.813567457264, 4663.650226232979, 4670.136024835417, 5344.599155063386, 5393.325834270716, 5399.892002159935, 5400.675959442446, 5437.4562543745305, 4608.28571571407, 4619.330197121399, 4620.145273124483, 4623.491415944243, 4665.253559430543, 4662.930056049162, 4706.987997580537, 4763.833265835679, 4775.5224477551965, 4863.294822250754, 4932.112219800327, 4933.605311575137, 4934.925976110289, 4937.530934561211, 4938.777755001105, 5383.946160538501, 5397.406285308692, 5437.510624043855, 5441.891162176814, 5458.808941687022, 4955.182394904945, 4998.950010499994, 5013.448520662797, 5025.773840177128, 5060.291559181791, 5131.897362052813, 5157.7679004444135, 5229.790808367623, 5301.151815709468, 5350.0, 5290.047791397432, 5292.576593872558, 5297.046531624344, 5297.258383826191, 5298.576113910955, 5111.1311077117725, 5134.717590532557, 5147.58819294448, 5148.948510514847, 5204.245384419162, 5002.124628190125, 5021.1213037717525, 5104.259882316969, 5117.0, 5204.34945631796, 4952.0, 5028.094942910165, 5047.444781074152, 5052.1663925451885, 5059.114654935298, 5076.82231121909, 5088.567471764942, 5106.387233532, 5130.589552835839, 5133.845984620468, 5125.0, 5137.51193636604, 5147.459516750687, 5176.223566465061, 5196.896062078662], "value": 4854.52807109609, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [696.3941371007223, 715.7924201981425, 730.8026832755156, 742.8848528478081, 744.8547533231018, 35062.82468587656, 35487.82256088722, 35666.46500302491, 35783.4632480513, 40131.0, 37104.44343334852, 37432.0, 37443.81278093606, 37474.4378834317, 37494.43758343627, 6810.387065164135, 6905.551139175963, 7130.607816570074, 7232.674529646179, 7247.601381923992, 8609.95695021524, 8759.299256059532, 8804.823903521925, 8806.911930880673, 8996.820063598723, 8613.870791938127, 8636.222739953402, 8651.783705407352, 8663.480191188517, 8832.249258813008, 8569.185927336894, 8583.313334933191, 8585.141485851427, 8587.0, 8601.741947741577, 9119.0, 9122.863157052583, 9127.634894604207, 9143.862842057375, 9161.129692679251, 34326.0, 34427.82786086079, 34553.0, 34618.0, 34727.0, 3359.6472370401, 3363.8486268117995, 3372.2243883906594, 3400.0, 3429.0, 22492.437689057904, 22745.886270568706, 23691.28926132219, 23820.047198112054, 23884.880575597184, 3056.908292751221, 3073.707997740211, 3197.904062878117, 3268.1339445047083, 3269.084656296217, 144233.0, 145069.0, 145232.99999999895, 146035.0, 146144.0, 35433.29133417317, 36004.81997590048, 38776.22447551033, 38938.80530597329, 42528.787356063025, 42025.369619455734, 46532.53467465282, 46694.0, 46834.76582617065, 46889.0, 10271.075603195748, 10403.0, 12119.697007574881, 12162.209456385306, 12261.203021803554, 8861.158189971942, 8979.0, 9182.403143795633, 9218.492982886006, 9238.491882946502, 12914.225146491053, 12947.287899165636, 13012.934935325453, 13033.47866085346, 13077.803832942513, 5105.617078719111, 5117.616178786606, 5173.430922598511, 5206.687598744087, 5263.973680131575, 976.9609215631295, 981.097390400833, 992.2954702161546, 1009.5911155981839, 1017.699778565325, 21664.133434662752, 21679.34961951144, 21749.13003479875, 21853.344399668036, 21922.89038554829, 1067.2849191042021, 1083.3987137138806, 1085.7285678580356, 1092.3391348234363, 1093.557109370706, 11128.833067503994, 11630.709232269091, 11657.533698652129, 11744.58893938708, 11747.236429632047, 240848.0, 242195.0, 242942.0, 243300.0, 243336.0, 42436.363454548205, 42911.35632965508, 42967.14065718668, 42972.355414668804, 42996.0, 1185.9589528610863, 1225.7977433723513, 1233.975320493585, 1234.8147777833217, 1236.8082947143207, 20255.4936126598, 20311.79688203099, 21424.0, 21442.57114857663, 21618.459538511663, 35207.11982200466, 35427.46858797069, 35431.468527971585, 35440.822795885855, 35479.11302217362, 218833.0, 219646.0, 220283.0, 327583.0, 332160.0, 25436.364090897874, 30374.696253037186, 30602.540961886036, 30987.91542296009, 31140.532892006184, 33047.66952330446, 33329.18345293343, 33639.32721345608, 34331.313373731886, 34331.31337373288, 28412.43175136527, 28609.713902860705, 28940.710592894644, 29158.56262156112, 29237.85381073081, 28304.5941095001, 28353.29116772097, 28567.714322856504, 29065.12804615865, 29279.56080658749, 29178.270543236587, 29259.122226333246, 29376.11871643854, 29682.406351873273, 33052.04219367114, 25948.0, 27346.855111662415, 28494.57258141088, 28803.0, 32287.192820179684, 23134.305970820904, 23482.412939676644, 23644.29067127989, 23716.52566948686, 23750.0], "value": 15518.221544299482, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.06234413965086, 395.85551273785074, 397.41381462343037, 416.97289676171044, 424.6305714028795, 11800.645980620573, 13627.931860340697, 13915.58253252404, 19314.130864111114, 19491.0, 18916.81083189168, 19360.903195484003, 19875.801241987574, 20311.49221269469, 20392.184312627476, 4913.82801601944, 5785.681787501686, 6014.8195554133445, 6043.063325184604, 6055.424734650202, 5088.211327244265, 5864.4135586441225, 5904.439078287556, 5912.320083190445, 5914.852128696774, 5906.173135760997, 5908.025175846002, 5909.793157239497, 5912.379200183962, 6693.196816382041, 6993.720251189946, 7104.573725576482, 7105.57366558003, 7110.182329032175, 7111.502194846363, 6720.462363010947, 6961.65191740411, 7003.15962084548, 7009.08881845362, 7020.438364930793, 23807.285781426584, 23964.64053039206, 24225.0, 24338.148164814324, 24390.146344878023, 2337.4506990857135, 2404.4349577849193, 2406.2660888429023, 2440.8535487870786, 2483.726790053093, 14670.706585868329, 14864.256787160706, 14886.255687215596, 14986.0, 15797.60505987348, 1766.752654628353, 1838.7496502378378, 1842.1157844234842, 1853.1938606705992, 1874.681304178293, 91655.0, 93585.53207233988, 94170.52914735382, 94260.0, 96011.0, 16976.915115424592, 17620.383286584907, 17642.823571764377, 17758.46724598264, 18043.639127217382, 32233.838830805696, 32521.837390812896, 32856.34287314241, 32932.0, 33143.502847457305, 8291.95854020738, 8359.707410240613, 8681.392302538761, 8773.07882672323, 8780.297576194016, 6622.03980422836, 6662.633555154416, 6748.763793267212, 6901.068355772007, 6952.304769523108, 8918.331125165638, 9069.36751384757, 9128.0, 9261.67584134552, 9450.52747362629, 3500.38904295431, 3509.8596056157467, 3693.4644476550748, 3701.759385639925, 3848.8460461581785, 754.1515794730927, 782.8395178988408, 791.4103992525605, 812.6830536090929, 813.6663967773185, 18270.63458730818, 19437.0, 19546.511337216398, 19627.0, 19940.0, 763.3549650545281, 769.5844244108231, 778.7741554949115, 783.3537331701369, 790.5612385126195, 9894.604215831287, 10785.555433666135, 10846.045359632792, 10869.836702683016, 10878.129749620011, 472693.0, 473479.0, 487143.0, 491656.0, 496305.0, 86065.0, 86278.0, 86646.0, 87109.0, 89135.55432222797, 1055.1453322808702, 1064.595453727594, 1088.0370871778532, 1103.862017247844, 1110.211749657752, 15874.539446385366, 16391.672166556364, 16626.418075367303, 16817.327306907588, 17101.0, 41010.589894100674, 41723.0, 41771.0, 41868.79065604653, 42500.0, 53763.19355209753, 54162.45837541574, 54181.0, 54348.0, 54650.453495464535, 7552.697892084255, 10282.0, 10378.792424151323, 10988.945055274673, 11032.613858514913, 12354.25874447536, 12490.68773280639, 12531.18547294423, 12578.622641320775, 12894.226346419246, 11016.50425730828, 11041.613543525938, 11068.335899846035, 11392.202545821712, 11563.074954003492, 9416.0, 9432.151106400457, 9487.146156845916, 9555.569999350186, 9577.0, 11079.5568177272, 11110.222284440011, 11145.331280123219, 11505.309681419141, 11620.128490363426, 11409.372484513431, 11427.314361138358, 11459.255148415326, 11474.254173478697, 11822.704432388915, 11003.559857605926, 11033.779324413626, 11252.549898003988, 11512.94243528777, 11542.0], "value": 9969.431343591106, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1303.7848754955432, 1421.708549747302, 1441.5026815748565, 1458.117838707582, 1465.8827293816491, 7932.484388514743, 9363.204127649149, 9617.615295388185, 9874.456904870229, 9902.752431189207, 9596.280278979088, 9677.080677335642, 9680.0, 9692.176165025981, 9697.175740062103, 1894.5831916978277, 1939.1952339779045, 1946.8442524598, 1947.123794292567, 1947.7273181754565, 1676.8993860368416, 1741.686496430642, 1978.3669225847734, 2033.3290014295321, 2041.397787652646, 1985.0868600443814, 2002.0590322548378, 2008.3874418302412, 2010.431863146748, 2012.3761633893466, 1932.062949469506, 1963.980360196394, 1982.692682634194, 1984.3848406993877, 1988.880667159975, 1920.1647283431753, 1939.5829896572304, 1944.1834429539626, 1968.1438574220117, 1969.4977780665981, 9629.518524073768, 9724.70825875225, 9725.610975560969, 9736.367136136128, 9740.4642744649, 4713.0, 4836.903261934777, 4838.201696720037, 4844.346013288196, 4849.684770489942, 2590.9481810363877, 2623.22614828626, 2650.3506640872915, 2676.705562388155, 2681.115231973464, 993.3841018568462, 1006.1648831469862, 1008.8284991551454, 1048.1667074675652, 1056.4928834159646, 11957.94021029898, 12217.450214740269, 12535.18521296122, 12602.81095783564, 12604.558840440632, 3728.7203459740626, 3778.6221377862544, 3860.452101612922, 3862.547282475592, 3883.728139030241, 9457.10157535033, 9488.430694158373, 9493.857592136124, 9495.43027418357, 9520.381175223589, 4660.161170989187, 4663.953360466419, 4664.766761661904, 4666.32338310943, 4667.183242932473, 4298.763568003727, 4320.848770293024, 4378.387025816388, 4396.120775844844, 4472.686911916199, 3208.0, 3213.855376508063, 3275.1157187559224, 3297.7856439331367, 3299.043277449513, 875.1336177184669, 877.5305211711703, 880.2737741363272, 889.755317287751, 894.1728900766765, 619.3434958943534, 632.6931438252444, 633.8954072578065, 648.7859006527834, 655.7475371981726, 5376.327959005124, 5446.7276636168035, 5453.836384908459, 5484.7531861066345, 5804.970975145097, 844.3118858130726, 862.7368652560904, 875.9649614015368, 881.5548148185254, 883.6023789294843, 3464.7401444891734, 3470.410030294856, 3493.5807703075793, 3533.2050288685355, 3592.946105808415, 11523.07815374768, 11910.235905637814, 12028.518859245532, 12111.818322725167, 12190.146689731633, 11658.766824663458, 12014.939925300318, 12023.819642705366, 12032.27806331623, 12034.699132521757, 8692.087330830298, 8857.557122143997, 8877.644894204288, 8879.334049946408, 8890.688825891191, 5468.808591699271, 5520.861978450571, 5538.390777014606, 5591.776328946797, 5711.771529138954, 10559.419231942009, 10569.418681972566, 10594.735131621772, 10737.731556711145, 10768.0, 10446.0, 10889.782204356026, 10919.126469882549, 11186.944065279948, 11199.21605487608, 7198.5680859148615, 7392.223816499405, 7696.422768292512, 7893.486923349964, 8144.511329320259, 8912.153345432174, 9421.057894210524, 9427.434353938786, 9429.905700942903, 9461.621535138793, 8192.262696357357, 8229.094799571923, 8243.711470098518, 8342.374321925758, 8366.121557236402, 8018.278354948083, 8027.799305017421, 8114.066882308374, 8117.10711821711, 8142.592870356577, 7093.609851458013, 7263.237360077116, 7265.200827909031, 7266.745663901738, 7277.38142257914, 4925.408950925912, 4976.427710813303, 5019.347484826949, 5056.342675452168, 5084.51697088776, 5062.215356619583, 5133.8716532087, 5242.108841497031, 5249.0, 5280.102382594891], "value": 4348.73770293302, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [339.3840180073167, 341.9247765491591, 351.3727995527983, 357.8658003248782, 365.7787038841503, 4769.856904292868, 4774.713517188971, 4776.349126234947, 4793.082766893244, 4807.8798030049265, 4516.548345165482, 4612.723236605806, 4651.674382793198, 4674.11062061802, 4714.292856071591, 3918.490596222487, 3931.7640941543455, 3935.9999999999927, 3938.5076865391825, 3940.152867133566, 3907.5115610548683, 3933.9016524586973, 3975.82108805103, 3978.2242462719782, 3982.4026396040535, 3763.7929913854728, 3939.9803000984957, 3967.761934283938, 3990.902501811996, 3991.44119823225, 3917.0, 3918.784466854322, 3934.822932967995, 3943.1325108475944, 3943.8422463101583, 3631.6186800385844, 3644.9817750911343, 3649.94525082124, 3659.2864391443677, 3687.7418580699364, 4606.60843828275, 4610.147122782296, 4615.8615241542475, 4621.976890115561, 4647.5135802345585, 4500.0074950158105, 4545.36364908913, 4694.2723877799, 4722.929156062662, 4799.3760811094335, 4969.975150124226, 4983.875403114915, 4999.875003124915, 5011.498850114996, 5026.064964988469, 4363.912721745579, 4381.671374646914, 4408.3248365621175, 4415.20526305265, 4419.690621656486, 5058.116873382173, 5190.455002224788, 5244.8688782780355, 5265.86835329116, 5340.198970154469, 4458.238995596721, 4479.888002799956, 4486.528914463999, 4555.316702494586, 4622.19111655459, 4592.219322715079, 4600.401947746772, 4637.976810115928, 4651.2557990721325, 4675.275332323496, 4419.779011049434, 4704.788284527204, 4713.397444868761, 4732.219183834629, 4739.336492890998, 4912.38595175603, 4933.45731969483, 4944.826931057468, 4948.282499037619, 4949.529794669573, 1584.4375246787456, 1588.6743217640355, 1592.4426450742149, 1592.7610858371106, 1598.448535255335, 1245.8997245393457, 1305.3342795174528, 1312.3766211049674, 1324.4966912573352, 1335.3723749837561, 4148.5065376464445, 4270.508891477458, 4278.0374415756205, 4301.677374196947, 4312.757366169637, 5041.924371134436, 5054.014467178865, 5063.56948664643, 5078.365204349457, 5084.9745751271, 4238.470191226097, 4239.936400953989, 4257.574242575718, 4325.264705000158, 4325.286327755948, 2502.712188098392, 2655.74770396812, 2657.096587160336, 2664.200739778059, 2669.6529451171614, 4737.739424331626, 4738.881527961759, 4744.197205062123, 4765.785539650724, 4787.497312782178, 4916.328448327586, 5029.698218106852, 5184.818531351385, 5185.0407674579565, 5205.713685747244, 4610.953890461053, 4681.602063824613, 4700.2009658358165, 4711.646626503095, 4735.389967411097, 4999.250112483011, 5023.4725353838785, 5027.446980832033, 5044.015227969862, 5068.594512438923, 4749.525047495223, 4867.5862551682085, 4878.902421951612, 4946.208606622923, 4971.9863455300665, 4653.162430762495, 4654.37165982588, 4664.4869064403565, 4703.482616912069, 4739.886126760278, 4452.1763473757455, 4474.306482495218, 4477.895389167086, 4481.395011673382, 4510.5340764252405, 4719.622430205507, 4994.5754610858485, 5001.274815151855, 5045.502476274268, 5075.720835354091, 4883.853484395474, 4900.754962251945, 4906.239532872411, 4908.63185261114, 4916.778744956414, 4847.442544107473, 4873.1959226727195, 4881.780319885685, 4919.262110683426, 4925.778339974781, 4568.725876447424, 4800.639952003684, 4822.324874517641, 4828.686135401188, 4836.469377354621, 4926.3842019747535, 4941.65408421407, 4945.876353091202, 4946.3817022872145, 4959.256111583291, 4765.976170119266, 4798.352222449925, 4800.591949684316, 4815.181419158681, 4840.273958906192], "value": 3958.824268687088, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.2955143669119, 659.9835004124893, 673.4645956464611, 681.9761308354207, 698.8951657251412, 12039.879601203986, 13049.217046977188, 13214.141080829739, 13295.335233238347, 13296.335183240835, 12547.058970577198, 12599.181053231534, 12749.043821713361, 13209.273489958048, 13369.997250206225, 818.9099199088096, 847.1105339393642, 847.3602430165216, 852.6248450681711, 854.090393730678, 838.2958315015417, 848.9897022543184, 857.0, 860.711661593367, 863.568215892054, 876.8246350729847, 878.4246318661255, 878.7759121424028, 879.2877769007092, 880.3573391424264, 874.9475031498099, 877.1929824561387, 879.3361012435635, 884.3765145572356, 885.3183049052194, 652.0447544347506, 657.1653999420708, 657.9144711187563, 661.1075048684286, 662.1788981662752, 13495.392707328194, 13833.377498012613, 13861.376238069312, 13869.167849928936, 14594.343254553465, 13644.317784110755, 14088.013839031271, 14223.146611203361, 14336.0, 14345.110189395791, 9880.802383952281, 9959.80080398388, 9961.0, 10206.744831379201, 10378.63674771387, 3108.4870996285586, 3110.0825256549147, 3122.9219269518217, 3137.607799025122, 3166.208447888028, 66400.3359966399, 66572.3342766571, 67058.66470667615, 67113.66443167801, 69385.30614693838, 10955.561777528968, 10957.287776294515, 10978.890211097947, 11062.834057489144, 11619.535218591162, 22069.668954965688, 22080.668789968164, 22091.226807061677, 22104.33686989393, 22111.226107086175, 6012.969935150296, 6021.187139736079, 6171.938280617136, 6260.46786023184, 6443.645599491979, 3329.217633856042, 3469.705075068597, 3486.4770284457536, 3511.0871173495075, 3512.8946131616094, 2596.9870150649126, 2635.5387807133675, 2667.733226677317, 2669.906553270665, 2678.5178667839978, 444.613186527723, 445.1853108810868, 449.0905915521031, 453.6302913125792, 455.3920516110963, 534.8235082422791, 549.5548605629454, 571.828451464559, 580.4775701868352, 586.7975548435783, 7955.323797477279, 8076.0, 8234.970628671415, 8257.463264887763, 8650.221480066699, 518.6218909904317, 522.6550476685445, 533.9519443250126, 553.0239127939191, 558.8267637032452, 3722.6919310027415, 3770.490983717218, 3791.279656865187, 4029.5366032906004, 4689.0, 59283.40716592865, 60450.0, 61429.0, 63870.6806465974, 64126.38104284395, 46116.76941615337, 47100.7644961773, 48950.510494894595, 49585.25622115671, 50815.49184508107, 44938.55061449343, 45300.546994529635, 45347.0, 45447.318290225674, 47541.762291189014, 8452.74641760748, 8893.0, 8971.237444817263, 9050.818983620422, 9072.092790720875, 32278.677213227566, 33269.33461330712, 33969.49045764266, 34060.659393405746, 35253.29493410169, 37835.43246851354, 38256.23487530289, 38294.0, 39122.0, 39157.412638809874, 11412.600558980395, 11552.884471155181, 11665.533378665097, 11671.0, 12110.333931633844, 12649.87350126487, 12697.55558555446, 12766.936165319114, 13111.344432778515, 13462.596122116352, 11865.881341186478, 12309.893013599492, 12334.444949977093, 12457.750844983231, 12578.182418142791, 11204.439778010903, 11209.0, 11402.315861048364, 11421.657350279505, 11808.645740627795, 10905.491736900716, 11052.336859788438, 11334.319940803578, 11366.829497557377, 11410.94294528522, 9159.450432974043, 9333.953330233306, 9341.0, 9426.764330891783, 9440.19758320523, 8543.957280213808, 8579.313654907717, 8980.550972451481, 9126.954365228132, 9267.907320926704], "value": 6203.319205147878, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1552.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 117.0, 118.0, 117.0, 118.0, 118.0, 116.0, 117.0, 118.0, 118.0], "value": 116.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 128.0, 130.0, 164.0, 128.0, 125.0, 124.0, 122.0, 151.0, 125.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 163.0, 162.0, 162.0, 162.0, 163.0, 164.0, 164.0], "value": 162.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 77.0, 119.0, 76.0, 75.0, 76.0, 76.0, 104.0, 77.0], "value": 83.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 109.0, 84.0, 84.0, 84.0, 108.0, 85.0, 84.0, 121.0], "value": 92.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 150.0, 148.0, 149.0, 149.0, 149.0, 149.0, 152.0, 151.0], "value": 149.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 67.0, 68.0, 67.0, 67.0, 67.0, 66.0, 67.0], "value": 66.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 56.0, 55.0, 55.0, 56.0, 55.0, 56.0, 55.0], "value": 55.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 86.0, 86.0, 95.0, 92.0, 93.0, 86.0, 94.0], "value": 89.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 137.0, 134.0, 132.0, 134.0, 133.0, 151.0, 175.0, 160.0], "value": 142.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 191.0, 179.0, 178.0, 184.0, 184.0, 180.0, 182.0, 179.0], "value": 182.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 68.0, 67.0, 72.0, 68.0, 65.0, 83.0, 66.0, 67.0], "value": 69.4, "unit": "score"}]}]} 08:35:07 INFO - Return code: 0 08:35:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:35:07 ERROR - # TBPL SUCCESS # 08:35:07 INFO - Running post-action listener: _resource_record_post_action 08:35:07 INFO - [mozharness: 2017-03-10 16:35:07.978950Z] Finished run-tests step (success) 08:35:07 INFO - Running post-run listener: _resource_record_post_run 08:35:08 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 4096; Write bytes: 354455552; Read time: 8; Write time: 344072 08:35:08 INFO - TinderboxPrint: CPU usage
13.3% 08:35:08 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 08:35:08 INFO - TinderboxPrint: I/O write bytes / time
354,455,552 / 344,072 08:35:08 INFO - TinderboxPrint: CPU idle
8,341.3 (86.7%) 08:35:08 INFO - TinderboxPrint: CPU user
1,225.7 (12.7%) 08:35:08 INFO - TinderboxPrint: Swap in / out
0 / 0 08:35:08 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 111296512; Read time: 0; Write time: 164028 08:35:08 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 243159040; Read time: 8; Write time: 180044 08:35:08 INFO - Running post-run listener: _upload_blobber_files 08:35:08 INFO - Blob upload gear active. 08:35:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:35:08 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 08:35:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:35:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:35:09 INFO - (blobuploader) - INFO - Open directory for files ... 08:35:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:35:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:35:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:09 INFO - (blobuploader) - INFO - Done attempting. 08:35:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:35:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:10 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:35:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:10 INFO - (blobuploader) - INFO - Done attempting. 08:35:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:35:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:35:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:14 INFO - (blobuploader) - INFO - Done attempting. 08:35:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:35:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:35:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:35:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:35:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:35:15 INFO - (blobuploader) - INFO - Done attempting. 08:35:15 INFO - (blobuploader) - INFO - Iteration through files over. 08:35:15 INFO - Return code: 0 08:35:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:35:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:35:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/760c508be99044164d4dc4b9153c14394ffc0c5a91e59dd1eed12f055e0d1fde5999d9aad75883881a06eceb16e616ece35dfc7d59b43df589d1434dc1a31fb5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35cba7586d050d726078c58e314f63aa43af3e793957cf43a88f9226abe90ea6f533f83868fe90ada716305dce8607464ad0c3508414c48d36b08099c08d0d70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f1301fa35ff83049aa84f094fd1c56b7f5b0a7e10a49c85a2f4fbed651a3717efb97bb12f9f6ae8f4e0c109ab91ee53c9a93222ff2d9fba7e7e756c846ec2d41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aed162c3a428a7540d6b92d20b77dec314181739d4f59732f151da22d33f970dab3623a9a424d2ae4d3785be77bba385afb62031b891ab2953bc2ce508567f85"} 08:35:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:35:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:35:15 INFO - Contents: 08:35:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/760c508be99044164d4dc4b9153c14394ffc0c5a91e59dd1eed12f055e0d1fde5999d9aad75883881a06eceb16e616ece35dfc7d59b43df589d1434dc1a31fb5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35cba7586d050d726078c58e314f63aa43af3e793957cf43a88f9226abe90ea6f533f83868fe90ada716305dce8607464ad0c3508414c48d36b08099c08d0d70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f1301fa35ff83049aa84f094fd1c56b7f5b0a7e10a49c85a2f4fbed651a3717efb97bb12f9f6ae8f4e0c109ab91ee53c9a93222ff2d9fba7e7e756c846ec2d41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aed162c3a428a7540d6b92d20b77dec314181739d4f59732f151da22d33f970dab3623a9a424d2ae4d3785be77bba385afb62031b891ab2953bc2ce508567f85"} 08:35:15 INFO - Running post-run listener: copy_logs_to_upload_dir 08:35:15 INFO - Copying logs to upload dir... 08:35:15 INFO - mkdir: /builds/slave/test/build/upload/logs 08:35:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.152176 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2017-03-10 08:35:14.669153) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 08:35:14.672486) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/760c508be99044164d4dc4b9153c14394ffc0c5a91e59dd1eed12f055e0d1fde5999d9aad75883881a06eceb16e616ece35dfc7d59b43df589d1434dc1a31fb5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35cba7586d050d726078c58e314f63aa43af3e793957cf43a88f9226abe90ea6f533f83868fe90ada716305dce8607464ad0c3508414c48d36b08099c08d0d70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f1301fa35ff83049aa84f094fd1c56b7f5b0a7e10a49c85a2f4fbed651a3717efb97bb12f9f6ae8f4e0c109ab91ee53c9a93222ff2d9fba7e7e756c846ec2d41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aed162c3a428a7540d6b92d20b77dec314181739d4f59732f151da22d33f970dab3623a9a424d2ae4d3785be77bba385afb62031b891ab2953bc2ce508567f85"} build_url:https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/WvtXCtJdQ9uh9h8Z5Q04-w/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/760c508be99044164d4dc4b9153c14394ffc0c5a91e59dd1eed12f055e0d1fde5999d9aad75883881a06eceb16e616ece35dfc7d59b43df589d1434dc1a31fb5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/35cba7586d050d726078c58e314f63aa43af3e793957cf43a88f9226abe90ea6f533f83868fe90ada716305dce8607464ad0c3508414c48d36b08099c08d0d70", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f1301fa35ff83049aa84f094fd1c56b7f5b0a7e10a49c85a2f4fbed651a3717efb97bb12f9f6ae8f4e0c109ab91ee53c9a93222ff2d9fba7e7e756c846ec2d41", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/aed162c3a428a7540d6b92d20b77dec314181739d4f59732f151da22d33f970dab3623a9a424d2ae4d3785be77bba385afb62031b891ab2953bc2ce508567f85"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 08:35:14.697677) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 08:35:14.697978) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1489162449.300169-228279799 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004373 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 08:35:14.781595) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 08:35:14.781879) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 08:35:14.782152) ========= ========= Total master_lag: 0.15 =========