builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-053 starttime: 1491407651.27 results: success (0) revision: 720b9177c6856c1c4339d0fac1bf5149c0d53950 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 08:54:11.268109) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 08:54:11.268808) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 08:54:11.269287) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 08:54:11.285730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 08:54:11.286226) ========= 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=920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-05 08:54:11-- 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% 49.8M=0s 2017-04-05 08:54:11 (49.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.115818 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 08:54:11.417353) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 08:54:11.417662) ========= 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=920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019888 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 08:54:11.467695) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 08:54:11.468079) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 720b9177c6856c1c4339d0fac1bf5149c0d53950 --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 720b9177c6856c1c4339d0fac1bf5149c0d53950 --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=920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-05 08:54:11,574 truncating revision to first 12 chars 2017-04-05 08:54:11,574 Setting DEBUG logging. 2017-04-05 08:54:11,574 attempt 1/10 2017-04-05 08:54:11,574 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/720b9177c685?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-05 08:54:11,948 unpacking tar archive at: mozilla-central-720b9177c685/testing/mozharness/ program finished with exit code 0 elapsedTime=0.771321 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 08:54:12.253864) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 08:54:12.254184) ========= script_repo_revision: 720b9177c6856c1c4339d0fac1bf5149c0d53950 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 08:54:12.254544) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 08:54:12.254824) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 08:54:12.266502) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-04-05 08:54:12.266951) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:54:12 INFO - MultiFileLogger online at 20170405 08:54:12 in /builds/slave/test 08:54:12 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:54:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:54:12 INFO - {'append_to_log': False, 08:54:12 INFO - 'base_work_dir': '/builds/slave/test', 08:54:12 INFO - 'blob_upload_branch': 'Firefox', 08:54:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:54:12 INFO - 'branch': 'Firefox', 08:54:12 INFO - 'buildbot_json_path': 'buildprops.json', 08:54:12 INFO - 'config_files': ('talos/linux_config.py',), 08:54:12 INFO - 'default_actions': ('clobber', 08:54:12 INFO - 'read-buildbot-config', 08:54:12 INFO - 'download-and-extract', 08:54:12 INFO - 'populate-webroot', 08:54:12 INFO - 'create-virtualenv', 08:54:12 INFO - 'install', 08:54:12 INFO - 'run-tests'), 08:54:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:54:12 INFO - 'download_minidump_stackwalk': True, 08:54:12 INFO - 'download_symbols': 'ondemand', 08:54:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:54:12 INFO - 'tooltool.py': '/tools/tooltool.py', 08:54:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:54:12 INFO - '/tools/misc-python/virtualenv.py')}, 08:54:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:54:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:54:12 INFO - 'gecko_profile': False, 08:54:12 INFO - 'gecko_profile_interval': 0, 08:54:12 INFO - 'installer_path': 'installer.exe', 08:54:12 INFO - 'log_level': 'info', 08:54:12 INFO - 'log_name': 'talos', 08:54:12 INFO - 'log_to_console': True, 08:54:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:54:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:54:12 INFO - 'opt_config_files': (), 08:54:12 INFO - 'pip_index': False, 08:54:12 INFO - 'suite': 'dromaeojs-e10s', 08:54:12 INFO - 'system_bits': '32', 08:54:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:54:12 INFO - 'title': 'talos-linux64-ix-053', 08:54:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:54:12 INFO - 'use_talos_json': True, 08:54:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:54:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:54:12 INFO - 'work_dir': 'build'} 08:54:12 INFO - [mozharness: 2017-04-05 15:54:12.472497Z] Running clobber step. 08:54:12 INFO - Running pre-action listener: _resource_record_pre_action 08:54:12 INFO - Running main action method: clobber 08:54:12 INFO - rmtree: /builds/slave/test/build 08:54:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:54:13 INFO - Running post-action listener: _resource_record_post_action 08:54:13 INFO - [mozharness: 2017-04-05 15:54:13.402116Z] Finished clobber step (success) 08:54:13 INFO - [mozharness: 2017-04-05 15:54:13.402216Z] Running read-buildbot-config step. 08:54:13 INFO - Running pre-action listener: _resource_record_pre_action 08:54:13 INFO - Running main action method: read_buildbot_config 08:54:13 INFO - Using buildbot properties: 08:54:13 INFO - { 08:54:13 INFO - "project": "", 08:54:13 INFO - "product": "firefox", 08:54:13 INFO - "who": "ffxbld@noreply.mozilla.org", 08:54:13 INFO - "installer_path": "public/build/target.tar.bz2", 08:54:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 08:54:13 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:54:13 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 08:54:13 INFO - "stage_platform": "linux64-stylo", 08:54:13 INFO - "basedir": "/builds/slave/test", 08:54:13 INFO - "buildnumber": 14, 08:54:13 INFO - "platform": "ubuntu64_hw_stylo", 08:54:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:54:13 INFO - "slavebuilddir": "test", 08:54:13 INFO - "taskId": "Ur433erxTe-uzYrodC_qKQ", 08:54:13 INFO - "branch": "mozilla-central", 08:54:13 INFO - "script_repo_revision": "production", 08:54:13 INFO - "revision": "720b9177c6856c1c4339d0fac1bf5149c0d53950", 08:54:13 INFO - "slavename": "talos-linux64-ix-053", 08:54:13 INFO - "repo_path": "mozilla-central" 08:54:13 INFO - } 08:54:13 INFO - Finding installer, test and symbols from parent task. 08:54:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ur433erxTe-uzYrodC_qKQ'}, attempt #1 08:54:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ur433erxTe-uzYrodC_qKQ'}, attempt #1 08:54:14 INFO - Task dependencies: Cf8BHR9NTTm3MbTeH25gsQ 08:54:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ'}, attempt #1 08:54:14 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ/artifacts/public/build/target.tar.bz2 08:54:14 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ/artifacts/public/build/test_packages.json 08:54:14 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ/artifacts/public/build/target.crashreporter-symbols.zip 08:54:14 INFO - Running post-action listener: _resource_record_post_action 08:54:14 INFO - [mozharness: 2017-04-05 15:54:14.756320Z] Finished read-buildbot-config step (success) 08:54:14 INFO - [mozharness: 2017-04-05 15:54:14.756536Z] Running download-and-extract step. 08:54:14 INFO - Running pre-action listener: _resource_record_pre_action 08:54:14 INFO - Running main action method: download_and_extract 08:54:14 INFO - mkdir: /builds/slave/test/build/tests 08:54: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:54:14 INFO - trying https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ/artifacts/public/build/target.test_packages.json 08:54:14 INFO - Downloading https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:54:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:54:15 INFO - Downloaded 986 bytes. 08:54:15 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:54:15 INFO - Using the following test package requirements: 08:54:15 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:54:15 INFO - u'common': [u'target.common.tests.zip'], 08:54:15 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:54:15 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:54:15 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:54:15 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:54:15 INFO - u'mozbase': [u'target.common.tests.zip'], 08:54:15 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:54:15 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:54:15 INFO - u'web-platform': [u'target.common.tests.zip', 08:54:15 INFO - u'target.web-platform.tests.zip'], 08:54:15 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:54:15 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:54:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ/artifacts/public/build/target.common.tests.zip 08:54:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:54:15 INFO - Fetch https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ/artifacts/public/build/target.common.tests.zip into memory 08:54:16 INFO - Expected file size: 58243126 08:54:16 INFO - Obtained file size: 58243126 08:54:26 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:54:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ/artifacts/public/build/target.common.tests.zip 08:54:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:54:26 INFO - Fetch https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ/artifacts/public/build/target.common.tests.zip into memory 08:54:27 INFO - Expected file size: 58243126 08:54:27 INFO - Obtained file size: 58243126 08:54:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ/artifacts/public/build/target.talos.tests.zip 08:54:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:54:38 INFO - Fetch https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ/artifacts/public/build/target.talos.tests.zip into memory 08:54:38 INFO - Expected file size: 14404152 08:54:38 INFO - Obtained file size: 14404152 08:54:39 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:54:39 INFO - trying https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ/artifacts/public/build/target.tar.bz2 08:54:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:54:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:54:40 INFO - Downloaded 59095299 bytes. 08:54:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ/artifacts/public/build/target.tar.bz2 08:54:40 INFO - mkdir: /builds/slave/test/properties 08:54:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:54:40 INFO - Writing to file /builds/slave/test/properties/build_url 08:54:40 INFO - Contents: 08:54:40 INFO - build_url:https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ/artifacts/public/build/target.tar.bz2 08:54:40 INFO - Running post-action listener: _resource_record_post_action 08:54:40 INFO - Running post-action listener: set_extra_try_arguments 08:54:40 INFO - [mozharness: 2017-04-05 15:54:40.158094Z] Finished download-and-extract step (success) 08:54:40 INFO - [mozharness: 2017-04-05 15:54:40.158190Z] Running populate-webroot step. 08:54:40 INFO - Running pre-action listener: _resource_record_pre_action 08:54:40 INFO - Running main action method: populate_webroot 08:54:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:54:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:54:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:54:40 INFO - '--tppagecycles', 08:54:40 INFO - '7'], 08:54:40 INFO - 'tests': ['tsvgm']}}, 08:54:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:54:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:54:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:54:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:54:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:54:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:54:40 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:54:40 INFO - 'talos_options': ['--disable-e10s'], 08:54:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:54:40 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:54:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:54:40 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:54:40 INFO - 'talos_options': ['--disable-e10s'], 08:54:40 INFO - 'tests': ['damp', 'tps']}, 08:54:40 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:54:40 INFO - 'tests': ['damp', 'tps']}, 08:54:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:54:40 INFO - 'tests': ['dromaeo_dom']}, 08:54:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:54:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:54:40 INFO - 'tests': ['basic_compositor_video']}, 08:54:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:54:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:54:40 INFO - 'tests': ['a11yr', 08:54:40 INFO - 'ts_paint', 08:54:40 INFO - 'tpaint', 08:54:40 INFO - 'sessionrestore', 08:54:40 INFO - 'sessionrestore_no_auto_restore', 08:54:40 INFO - 'tabpaint']}, 08:54:40 INFO - 'other-e10s': {'tests': ['a11yr', 08:54:40 INFO - 'ts_paint', 08:54:40 INFO - 'tpaint', 08:54:40 INFO - 'sessionrestore', 08:54:40 INFO - 'sessionrestore_no_auto_restore', 08:54:40 INFO - 'tabpaint']}, 08:54:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:54:40 INFO - 'ts_paint', 08:54:40 INFO - 'tpaint', 08:54:40 INFO - 'sessionrestore', 08:54:40 INFO - 'sessionrestore_no_auto_restore', 08:54:40 INFO - 'tabpaint']}, 08:54:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:54:40 INFO - 'ts_paint', 08:54:40 INFO - 'tpaint', 08:54:40 INFO - 'sessionrestore', 08:54:40 INFO - 'sessionrestore_no_auto_restore', 08:54:40 INFO - 'tabpaint']}, 08:54:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:54:40 INFO - 'tests': ['a11yr', 08:54:40 INFO - 'ts_paint', 08:54:40 INFO - 'tpaint', 08:54:40 INFO - 'sessionrestore', 08:54:40 INFO - 'sessionrestore_no_auto_restore', 08:54:40 INFO - 'tabpaint']}, 08:54:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:54:40 INFO - 'tests': ['a11yr', 08:54:40 INFO - 'ts_paint', 08:54:40 INFO - 'tpaint', 08:54:40 INFO - 'sessionrestore', 08:54:40 INFO - 'sessionrestore_no_auto_restore', 08:54:40 INFO - 'tabpaint']}, 08:54:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:54:40 INFO - 'tests': ['tsvgx', 08:54:40 INFO - 'tsvgr_opacity', 08:54:40 INFO - 'tart', 08:54:40 INFO - 'tscrollx', 08:54:40 INFO - 'cart', 08:54:40 INFO - 'tsvg_static']}, 08:54:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:54:40 INFO - 'tsvgr_opacity', 08:54:40 INFO - 'tart', 08:54:40 INFO - 'tscrollx', 08:54:40 INFO - 'cart', 08:54:40 INFO - 'tsvg_static']}, 08:54:40 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:54:40 INFO - 'talos_options': ['--disable-e10s'], 08:54:40 INFO - 'tests': ['tp5o']}, 08:54:40 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:54:40 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:54:40 INFO - 'talos_options': ['--disable-e10s', 08:54:40 INFO - '--xperf_path', 08:54:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:54:40 INFO - 'tests': ['tp5n']}, 08:54:40 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:54:40 INFO - 'talos_options': ['--xperf_path', 08:54:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:54:40 INFO - 'tests': ['tp5n']}}, 08:54:40 INFO - 'talos.zip': {'path': '', 08:54:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:54:40 INFO - Running post-action listener: _resource_record_post_action 08:54:40 INFO - [mozharness: 2017-04-05 15:54:40.171299Z] Finished populate-webroot step (success) 08:54:40 INFO - [mozharness: 2017-04-05 15:54:40.171388Z] Running create-virtualenv step. 08:54:40 INFO - Running pre-action listener: _resource_record_pre_action 08:54:40 INFO - Running main action method: create_virtualenv 08:54:40 INFO - Creating virtualenv /builds/slave/test/build/venv 08:54:40 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:54:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:54:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:54:40 INFO - Using real prefix '/usr' 08:54:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:54:40 INFO - Installing distribute.............................................................................................................................................................................................done. 08:54:42 INFO - Installing pip.................done. 08:54:42 INFO - Return code: 0 08:54:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:54:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:54:42 INFO - Reading from file tmpfile_stdout 08:54:42 INFO - Output received: 08:54: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:54:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:54: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:54:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54: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:54:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54: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 0x24551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f0290>, '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 0x26f0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f1040>, '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': '920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925', '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:54: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:54: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:54:42 INFO - Using env: {'DISPLAY': ':0', 08:54:42 INFO - 'HOME': '/home/cltbld', 08:54:42 INFO - 'LANG': 'en_US.UTF-8', 08:54:42 INFO - 'LANGUAGE': 'en_US:en', 08:54:42 INFO - 'LOGNAME': 'cltbld', 08:54:42 INFO - 'MAIL': '/var/mail/cltbld', 08:54:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:42 INFO - 'MOZ_NO_REMOTE': '1', 08:54:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:42 INFO - 'NO_EM_RESTART': '1', 08:54:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:42 INFO - 'PWD': '/builds/slave/test', 08:54:42 INFO - 'SHELL': '/bin/bash', 08:54:42 INFO - 'SHLVL': '1', 08:54:42 INFO - 'TERM': 'linux', 08:54:42 INFO - 'TMOUT': '86400', 08:54:42 INFO - 'USER': 'cltbld', 08:54:42 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925', 08:54:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:42 INFO - '_': '/tools/buildbot/bin/python'} 08:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:43 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:54:43 INFO - Cleaning up... 08:54:43 INFO - Return code: 0 08:54:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:54:43 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:54:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:43 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:54:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:43 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 0x24551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f0290>, '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 0x26f0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f1040>, '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': '920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925', '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:54:43 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:54:43 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:54:43 INFO - Using env: {'DISPLAY': ':0', 08:54:43 INFO - 'HOME': '/home/cltbld', 08:54:43 INFO - 'LANG': 'en_US.UTF-8', 08:54:43 INFO - 'LANGUAGE': 'en_US:en', 08:54:43 INFO - 'LOGNAME': 'cltbld', 08:54:43 INFO - 'MAIL': '/var/mail/cltbld', 08:54:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:43 INFO - 'MOZ_NO_REMOTE': '1', 08:54:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:43 INFO - 'NO_EM_RESTART': '1', 08:54:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:43 INFO - 'PWD': '/builds/slave/test', 08:54:43 INFO - 'SHELL': '/bin/bash', 08:54:43 INFO - 'SHLVL': '1', 08:54:43 INFO - 'TERM': 'linux', 08:54:43 INFO - 'TMOUT': '86400', 08:54:43 INFO - 'USER': 'cltbld', 08:54:43 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925', 08:54:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:43 INFO - '_': '/tools/buildbot/bin/python'} 08:54:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:43 INFO - Downloading/unpacking psutil>=3.1.1 08:54:43 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:54:43 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:54:43 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:54:43 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:54:43 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:54:43 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:54:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:54:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:54:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:54:45 INFO - Installing collected packages: psutil 08:54:45 INFO - Running setup.py install for psutil 08:54:45 INFO - building 'psutil._psutil_linux' extension 08:54:45 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:54: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:54:45 INFO - building 'psutil._psutil_posix' extension 08:54: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:54:46 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:54:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:54:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:54:46 INFO - Successfully installed psutil 08:54:46 INFO - Cleaning up... 08:54:46 INFO - Return code: 0 08:54:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:46 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 0x24551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f0290>, '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 0x26f0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f1040>, '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': '920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925', '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:54:46 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:54:46 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:54:46 INFO - Using env: {'DISPLAY': ':0', 08:54:46 INFO - 'HOME': '/home/cltbld', 08:54:46 INFO - 'LANG': 'en_US.UTF-8', 08:54:46 INFO - 'LANGUAGE': 'en_US:en', 08:54:46 INFO - 'LOGNAME': 'cltbld', 08:54:46 INFO - 'MAIL': '/var/mail/cltbld', 08:54:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:46 INFO - 'MOZ_NO_REMOTE': '1', 08:54:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:46 INFO - 'NO_EM_RESTART': '1', 08:54:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:46 INFO - 'PWD': '/builds/slave/test', 08:54:46 INFO - 'SHELL': '/bin/bash', 08:54:46 INFO - 'SHLVL': '1', 08:54:46 INFO - 'TERM': 'linux', 08:54:46 INFO - 'TMOUT': '86400', 08:54:46 INFO - 'USER': 'cltbld', 08:54:46 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925', 08:54:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:46 INFO - '_': '/tools/buildbot/bin/python'} 08:54:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:48 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:54:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:54:48 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:54:48 INFO - Installing collected packages: mozsystemmonitor 08:54:48 INFO - Running setup.py install for mozsystemmonitor 08:54:48 INFO - Successfully installed mozsystemmonitor 08:54:48 INFO - Cleaning up... 08:54:48 INFO - Return code: 0 08:54:48 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:48 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 0x24551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f0290>, '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 0x26f0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f1040>, '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': '920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925', '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:54:48 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:54:48 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:54:48 INFO - Using env: {'DISPLAY': ':0', 08:54:48 INFO - 'HOME': '/home/cltbld', 08:54:48 INFO - 'LANG': 'en_US.UTF-8', 08:54:48 INFO - 'LANGUAGE': 'en_US:en', 08:54:48 INFO - 'LOGNAME': 'cltbld', 08:54:48 INFO - 'MAIL': '/var/mail/cltbld', 08:54:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:48 INFO - 'MOZ_NO_REMOTE': '1', 08:54:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:48 INFO - 'NO_EM_RESTART': '1', 08:54:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:48 INFO - 'PWD': '/builds/slave/test', 08:54:48 INFO - 'SHELL': '/bin/bash', 08:54:48 INFO - 'SHLVL': '1', 08:54:48 INFO - 'TERM': 'linux', 08:54:48 INFO - 'TMOUT': '86400', 08:54:48 INFO - 'USER': 'cltbld', 08:54:48 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925', 08:54:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:48 INFO - '_': '/tools/buildbot/bin/python'} 08:54:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:49 INFO - Downloading/unpacking jsonschema==2.5.1 08:54:49 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:54:49 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:54:49 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:54:49 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:54:49 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:54:49 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:54:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:54:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:54: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:54: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:54: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:54: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:54: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:54: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:54:51 INFO - Downloading functools32-3.2.3-2.tar.gz 08:54:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:54:51 INFO - warning: no files found matching '*.txt' 08:54:51 INFO - no previously-included directories found matching 'build' 08:54:51 INFO - no previously-included directories found matching 'dist' 08:54:51 INFO - no previously-included directories found matching '.git*' 08:54:51 INFO - Installing collected packages: jsonschema, functools32 08:54:51 INFO - Running setup.py install for functools32 08:54:51 INFO - warning: no files found matching '*.txt' 08:54:51 INFO - no previously-included directories found matching 'build' 08:54:51 INFO - no previously-included directories found matching 'dist' 08:54:51 INFO - no previously-included directories found matching '.git*' 08:54:51 INFO - Successfully installed jsonschema functools32 08:54:51 INFO - Cleaning up... 08:54:51 INFO - Return code: 0 08:54:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f0290>, '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 0x26f0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f1040>, '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': '920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925', '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:54:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:54:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:54:51 INFO - Using env: {'DISPLAY': ':0', 08:54:51 INFO - 'HOME': '/home/cltbld', 08:54:51 INFO - 'LANG': 'en_US.UTF-8', 08:54:51 INFO - 'LANGUAGE': 'en_US:en', 08:54:51 INFO - 'LOGNAME': 'cltbld', 08:54:51 INFO - 'MAIL': '/var/mail/cltbld', 08:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:51 INFO - 'MOZ_NO_REMOTE': '1', 08:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:51 INFO - 'NO_EM_RESTART': '1', 08:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:51 INFO - 'PWD': '/builds/slave/test', 08:54:51 INFO - 'SHELL': '/bin/bash', 08:54:51 INFO - 'SHLVL': '1', 08:54:51 INFO - 'TERM': 'linux', 08:54:51 INFO - 'TMOUT': '86400', 08:54:51 INFO - 'USER': 'cltbld', 08:54:51 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925', 08:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:51 INFO - '_': '/tools/buildbot/bin/python'} 08:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:54:51 INFO - Cleaning up... 08:54:51 INFO - Return code: 0 08:54:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:54:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f0290>, '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 0x26f0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f1040>, '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': '920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925', '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:54:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:54:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:54:51 INFO - Using env: {'DISPLAY': ':0', 08:54:51 INFO - 'HOME': '/home/cltbld', 08:54:51 INFO - 'LANG': 'en_US.UTF-8', 08:54:51 INFO - 'LANGUAGE': 'en_US:en', 08:54:51 INFO - 'LOGNAME': 'cltbld', 08:54:51 INFO - 'MAIL': '/var/mail/cltbld', 08:54:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:51 INFO - 'MOZ_NO_REMOTE': '1', 08:54:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:51 INFO - 'NO_EM_RESTART': '1', 08:54:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:51 INFO - 'PWD': '/builds/slave/test', 08:54:51 INFO - 'SHELL': '/bin/bash', 08:54:51 INFO - 'SHLVL': '1', 08:54:51 INFO - 'TERM': 'linux', 08:54:51 INFO - 'TMOUT': '86400', 08:54:51 INFO - 'USER': 'cltbld', 08:54:51 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925', 08:54:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:51 INFO - '_': '/tools/buildbot/bin/python'} 08:54:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:51 INFO - Downloading/unpacking blobuploader==1.2.4 08:54: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:54: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:54: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:54: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:54: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:54: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:54:53 INFO - Downloading blobuploader-1.2.4.tar.gz 08:54:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:54:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:54:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:54:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:54:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:54:54 INFO - Downloading docopt-0.6.1.tar.gz 08:54:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:54:54 INFO - Installing collected packages: blobuploader, requests, docopt 08:54:54 INFO - Running setup.py install for blobuploader 08:54:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:54:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:54:54 INFO - Running setup.py install for requests 08:54:55 INFO - Running setup.py install for docopt 08:54:55 INFO - Successfully installed blobuploader requests docopt 08:54:55 INFO - Cleaning up... 08:54:55 INFO - Return code: 0 08:54:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:54:55 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:54:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:55 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:54:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:55 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 0x24551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f0290>, '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 0x26f0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f1040>, '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': '920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925', '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:54:55 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:54:55 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:54:55 INFO - Using env: {'DISPLAY': ':0', 08:54:55 INFO - 'HOME': '/home/cltbld', 08:54:55 INFO - 'LANG': 'en_US.UTF-8', 08:54:55 INFO - 'LANGUAGE': 'en_US:en', 08:54:55 INFO - 'LOGNAME': 'cltbld', 08:54:55 INFO - 'MAIL': '/var/mail/cltbld', 08:54:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:55 INFO - 'MOZ_NO_REMOTE': '1', 08:54:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:55 INFO - 'NO_EM_RESTART': '1', 08:54:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:55 INFO - 'PWD': '/builds/slave/test', 08:54:55 INFO - 'SHELL': '/bin/bash', 08:54:55 INFO - 'SHLVL': '1', 08:54:55 INFO - 'TERM': 'linux', 08:54:55 INFO - 'TMOUT': '86400', 08:54:55 INFO - 'USER': 'cltbld', 08:54:55 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925', 08:54:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:55 INFO - '_': '/tools/buildbot/bin/python'} 08:54:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:54:55 INFO - Running setup.py (path:/tmp/pip-pmALGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:54:55 INFO - Running setup.py (path:/tmp/pip-ZuS8oj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:54:55 INFO - Running setup.py (path:/tmp/pip-cfCE8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:54:55 INFO - Running setup.py (path:/tmp/pip-QP5gIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:54:55 INFO - Running setup.py (path:/tmp/pip-k4ChDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:54:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:54:55 INFO - Running setup.py (path:/tmp/pip-n3Kul9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:54:56 INFO - Running setup.py (path:/tmp/pip-AmAJSM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:54:56 INFO - Running setup.py (path:/tmp/pip-vuG5Nd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:54:56 INFO - Running setup.py (path:/tmp/pip-rbgwqd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:54:56 INFO - Running setup.py (path:/tmp/pip-Ne3xc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:54:56 INFO - Running setup.py (path:/tmp/pip-uuc1_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:54:56 INFO - Running setup.py (path:/tmp/pip-2P1Hls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:54:56 INFO - Running setup.py (path:/tmp/pip-iRK6Bj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:54:56 INFO - Running setup.py (path:/tmp/pip-rKWArj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:56 INFO - Running setup.py (path:/tmp/pip-VS2qhJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:54:56 INFO - Running setup.py (path:/tmp/pip-QYnuNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:54:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:54:56 INFO - Running setup.py (path:/tmp/pip-iC1apF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:54:56 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:54:56 INFO - Running setup.py install for manifestparser 08:54:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:54:56 INFO - Running setup.py install for mozcrash 08:54:57 INFO - Running setup.py install for mozdebug 08:54:57 INFO - Running setup.py install for mozdevice 08:54:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:54:57 INFO - Running setup.py install for mozfile 08:54:57 INFO - Running setup.py install for mozhttpd 08:54:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:54:57 INFO - Running setup.py install for mozinfo 08:54:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:54:57 INFO - Running setup.py install for mozInstall 08:54:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:54:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:54:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:54:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:54:57 INFO - Running setup.py install for mozleak 08:54:57 INFO - Running setup.py install for mozlog 08:54:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:54:57 INFO - Running setup.py install for moznetwork 08:54:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:54:57 INFO - Running setup.py install for mozprocess 08:54:58 INFO - Running setup.py install for mozprofile 08:54:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:54:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:54:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:54:58 INFO - Running setup.py install for mozrunner 08:54:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:54:58 INFO - Running setup.py install for mozscreenshot 08:54:58 INFO - Running setup.py install for moztest 08:54:58 INFO - Running setup.py install for mozversion 08:54:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:54:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:54:58 INFO - Cleaning up... 08:54:58 INFO - Return code: 0 08:54:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:54:58 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:54:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:54:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:58 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:54:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:54:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:54:58 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 0x24551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f0290>, '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 0x26f0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f1040>, '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': '920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925', '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:54:58 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:54:58 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:54:58 INFO - Using env: {'DISPLAY': ':0', 08:54:58 INFO - 'HOME': '/home/cltbld', 08:54:58 INFO - 'LANG': 'en_US.UTF-8', 08:54:58 INFO - 'LANGUAGE': 'en_US:en', 08:54:58 INFO - 'LOGNAME': 'cltbld', 08:54:58 INFO - 'MAIL': '/var/mail/cltbld', 08:54:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:58 INFO - 'MOZ_NO_REMOTE': '1', 08:54:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:58 INFO - 'NO_EM_RESTART': '1', 08:54:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:58 INFO - 'PWD': '/builds/slave/test', 08:54:58 INFO - 'SHELL': '/bin/bash', 08:54:58 INFO - 'SHLVL': '1', 08:54:58 INFO - 'TERM': 'linux', 08:54:58 INFO - 'TMOUT': '86400', 08:54:58 INFO - 'USER': 'cltbld', 08:54:58 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925', 08:54:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:58 INFO - '_': '/tools/buildbot/bin/python'} 08:54:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:54:58 INFO - Running setup.py (path:/tmp/pip-O21niX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:54: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:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:54:58 INFO - Running setup.py (path:/tmp/pip-cREs6w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:54: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:54:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:54:58 INFO - Running setup.py (path:/tmp/pip-myMaCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:54:59 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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:54:59 INFO - Running setup.py (path:/tmp/pip-At628N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:54:59 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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:54:59 INFO - Running setup.py (path:/tmp/pip-d9kfG_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:54:59 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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:54:59 INFO - Running setup.py (path:/tmp/pip-noxYWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:54:59 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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:54:59 INFO - Running setup.py (path:/tmp/pip-RvH1Uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:54:59 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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:54:59 INFO - Running setup.py (path:/tmp/pip-13Jygm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:54:59 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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:54:59 INFO - Running setup.py (path:/tmp/pip-hpqq57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:54:59 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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:54:59 INFO - Running setup.py (path:/tmp/pip-CIzYPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:54:59 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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:54:59 INFO - Running setup.py (path:/tmp/pip-MPol4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:54:59 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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:54:59 INFO - Running setup.py (path:/tmp/pip-R2q0rB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:54:59 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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:54:59 INFO - Running setup.py (path:/tmp/pip-phbf4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:54:59 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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:54:59 INFO - Running setup.py (path:/tmp/pip-ule5zs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:54:59 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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:54:59 INFO - Running setup.py (path:/tmp/pip-G5YmzV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:54: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:54:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:54:59 INFO - Running setup.py (path:/tmp/pip-pA5_20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:55:00 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:55:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:55:00 INFO - Running setup.py (path:/tmp/pip-RzmMBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:55:00 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:55:00 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:55:00 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:55:00 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:55:00 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:55:00 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:55:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:55:00 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:55:00 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:55:00 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:55:00 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:55:00 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:55:00 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:55:02 INFO - Downloading blessings-1.6.tar.gz 08:55:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:55:02 INFO - Installing collected packages: blessings 08:55:02 INFO - Running setup.py install for blessings 08:55:02 INFO - Successfully installed blessings 08:55:02 INFO - Cleaning up... 08:55:02 INFO - Return code: 0 08:55:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:55:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:55:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:55:02 INFO - Reading from file tmpfile_stdout 08:55:02 INFO - Current package versions: 08:55:02 INFO - argparse == 1.2.1 08:55:02 INFO - blessings == 1.6 08:55:02 INFO - blobuploader == 1.2.4 08:55:02 INFO - docopt == 0.6.1 08:55:02 INFO - functools32 == 3.2.3-2 08:55:02 INFO - jsonschema == 2.5.1 08:55:02 INFO - manifestparser == 1.1 08:55:02 INFO - mozInstall == 1.12 08:55:02 INFO - mozcrash == 1.0 08:55:02 INFO - mozdebug == 0.1 08:55:02 INFO - mozdevice == 0.49 08:55:02 INFO - mozfile == 1.2 08:55:02 INFO - mozhttpd == 0.7 08:55:02 INFO - mozinfo == 0.9 08:55:02 INFO - mozleak == 0.1 08:55:02 INFO - mozlog == 3.4 08:55:02 INFO - moznetwork == 0.27 08:55:02 INFO - mozprocess == 0.25 08:55:02 INFO - mozprofile == 0.28 08:55:02 INFO - mozrunner == 6.13 08:55:02 INFO - mozscreenshot == 0.1 08:55:02 INFO - mozsystemmonitor == 0.3 08:55:02 INFO - moztest == 0.8 08:55:02 INFO - mozversion == 1.4 08:55:02 INFO - psutil == 3.1.1 08:55:02 INFO - requests == 1.2.3 08:55:02 INFO - wsgiref == 0.1.2 08:55:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:02 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 0x24551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f0290>, '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 0x26f0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f1040>, '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': '920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925', '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:55:02 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:55:02 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:55:02 INFO - Using env: {'DISPLAY': ':0', 08:55:02 INFO - 'HOME': '/home/cltbld', 08:55:02 INFO - 'LANG': 'en_US.UTF-8', 08:55:02 INFO - 'LANGUAGE': 'en_US:en', 08:55:02 INFO - 'LOGNAME': 'cltbld', 08:55:02 INFO - 'MAIL': '/var/mail/cltbld', 08:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:02 INFO - 'MOZ_NO_REMOTE': '1', 08:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:02 INFO - 'NO_EM_RESTART': '1', 08:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:02 INFO - 'PWD': '/builds/slave/test', 08:55:02 INFO - 'SHELL': '/bin/bash', 08:55:02 INFO - 'SHLVL': '1', 08:55:02 INFO - 'TERM': 'linux', 08:55:02 INFO - 'TMOUT': '86400', 08:55:02 INFO - 'USER': 'cltbld', 08:55:02 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925', 08:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:02 INFO - '_': '/tools/buildbot/bin/python'} 08:55:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:02 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:55:02 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:55:02 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:55:02 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:55:02 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:55:02 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:55:02 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:55:02 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:55:02 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:55:02 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:55:02 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:55:02 INFO - Cleaning up... 08:55:02 INFO - Return code: 0 08:55:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:02 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 0x24551f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x254da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26f2b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26f0290>, '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 0x26f0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f1040>, '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': '920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925', '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:55:02 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:55:02 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:55:02 INFO - Using env: {'DISPLAY': ':0', 08:55:02 INFO - 'HOME': '/home/cltbld', 08:55:02 INFO - 'LANG': 'en_US.UTF-8', 08:55:02 INFO - 'LANGUAGE': 'en_US:en', 08:55:02 INFO - 'LOGNAME': 'cltbld', 08:55:02 INFO - 'MAIL': '/var/mail/cltbld', 08:55:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:02 INFO - 'MOZ_NO_REMOTE': '1', 08:55:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:02 INFO - 'NO_EM_RESTART': '1', 08:55:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:02 INFO - 'PWD': '/builds/slave/test', 08:55:02 INFO - 'SHELL': '/bin/bash', 08:55:02 INFO - 'SHLVL': '1', 08:55:02 INFO - 'TERM': 'linux', 08:55:02 INFO - 'TMOUT': '86400', 08:55:02 INFO - 'USER': 'cltbld', 08:55:02 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925', 08:55:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:02 INFO - '_': '/tools/buildbot/bin/python'} 08:55:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:55:03 INFO - Cleaning up... 08:55:03 INFO - Return code: 0 08:55:03 INFO - Running post-action listener: _resource_record_post_action 08:55:03 INFO - Running post-action listener: _start_resource_monitoring 08:55:03 INFO - Starting resource monitoring. 08:55:03 INFO - [mozharness: 2017-04-05 15:55:03.090057Z] Finished create-virtualenv step (success) 08:55:03 INFO - [mozharness: 2017-04-05 15:55:03.090563Z] Running install step. 08:55:03 INFO - Running pre-action listener: _resource_record_pre_action 08:55:03 INFO - Running main action method: install 08:55:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:55:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:55:03 INFO - Reading from file tmpfile_stdout 08:55:03 INFO - Detecting whether we're running mozinstall >=1.0... 08:55:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:55:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:55:03 INFO - Reading from file tmpfile_stdout 08:55:03 INFO - Output received: 08:55:03 INFO - Usage: mozinstall [options] installer 08:55:03 INFO - Options: 08:55:03 INFO - -h, --help show this help message and exit 08:55:03 INFO - -d DEST, --destination=DEST 08:55:03 INFO - Directory to install application into. [default: 08:55:03 INFO - "/builds/slave/test"] 08:55:03 INFO - --app=APP Application being installed. [default: firefox] 08:55:03 INFO - mkdir: /builds/slave/test/build/application 08:55:03 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:55:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:55:18 INFO - Reading from file tmpfile_stdout 08:55:18 INFO - Output received: 08:55:18 INFO - /builds/slave/test/build/application/firefox/firefox 08:55:18 INFO - Running post-action listener: _resource_record_post_action 08:55:18 INFO - [mozharness: 2017-04-05 15:55:18.538999Z] Finished install step (success) 08:55:18 INFO - [mozharness: 2017-04-05 15:55:18.539155Z] Running run-tests step. 08:55:18 INFO - Running pre-action listener: _resource_record_pre_action 08:55:18 INFO - Running main action method: run_tests 08:55:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:55:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:55:18 INFO - Python 2.7.3 08:55:18 INFO - Return code: 0 08:55:18 INFO - grabbing minidump binary from tooltool 08:55:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:55:18 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 0x26f0290>, '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 0x26f0b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26f1040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:55:18 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:55:18 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:55:18 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:55:18 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:55:18 INFO - Return code: 0 08:55:18 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:55:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:55:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:55:18 INFO - ENV: RUST_BACKTRACE is now 1 08:55:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:55:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:55:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:55:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-053 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:55:18 INFO - Using env: {'DISPLAY': ':0', 08:55:18 INFO - 'HOME': '/home/cltbld', 08:55:18 INFO - 'LANG': 'en_US.UTF-8', 08:55:18 INFO - 'LANGUAGE': 'en_US:en', 08:55:18 INFO - 'LOGNAME': 'cltbld', 08:55:18 INFO - 'MAIL': '/var/mail/cltbld', 08:55:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:55:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:55:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:18 INFO - 'MOZ_NO_REMOTE': '1', 08:55:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:55:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:55:18 INFO - 'NO_EM_RESTART': '1', 08:55:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:55:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:18 INFO - 'PWD': '/builds/slave/test', 08:55:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:55:18 INFO - 'RUST_BACKTRACE': '1', 08:55:18 INFO - 'SHELL': '/bin/bash', 08:55:18 INFO - 'SHLVL': '1', 08:55:18 INFO - 'TERM': 'linux', 08:55:18 INFO - 'TMOUT': '86400', 08:55:18 INFO - 'USER': 'cltbld', 08:55:18 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925', 08:55:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:18 INFO - '_': '/tools/buildbot/bin/python'} 08:55:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:55:18 INFO - mozversion application_buildid: 20170405151816 08:55:18 INFO - mozversion application_changeset: 720b9177c6856c1c4339d0fac1bf5149c0d53950 08:55:18 INFO - mozversion application_display_name: Nightly 08:55:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:55:18 INFO - mozversion application_name: Firefox 08:55:18 INFO - mozversion application_remotingname: firefox 08:55:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:55:18 INFO - mozversion application_vendor: Mozilla 08:55:18 INFO - mozversion application_version: 55.0a1 08:55:18 INFO - mozversion platform_buildid: 20170405151816 08:55:18 INFO - mozversion platform_changeset: 720b9177c6856c1c4339d0fac1bf5149c0d53950 08:55:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:55:18 INFO - mozversion platform_version: 55.0a1 08:55:18 INFO - using testdate: 1491407718 08:55:18 INFO - actual date: 1491407718 08:55:18 INFO - starting webserver on 'localhost:39788' 08:55:18 INFO - SUITE-START | Running 2 tests 08:55:18 INFO - TEST-START | dromaeo_css 08:55:18 INFO - operating with platform_type : linux_ 08:55:18 INFO - Initialising browser for dromaeo_css test... 08:55:18 INFO - TEST-INFO | started process 12634 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUKaHcY/profile http://localhost:39788/getInfo.html) 08:55:24 INFO - PID 12634 | __metrics Screen width/height:1600/1200 08:55:24 INFO - PID 12634 | colorDepth:24 08:55:24 INFO - PID 12634 | Browser inner width/height: 1024/697 08:55:24 INFO - PID 12634 | __metrics 08:55:25 ERROR - PID 12634 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 08:55:26 INFO - TEST-INFO | 12634: exit 0 08:55:26 INFO - Browser initialized. 08:55:26 INFO - Running cycle 1/1 for dromaeo_css test... 08:55:26 INFO - TEST-INFO | started process 12776 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUKaHcY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:55:38 INFO - PID 12776 | RSS: Main: 177651712 08:55:38 INFO - PID 12776 | 08:58:43 INFO - PID 12776 | Cycle 1(1): loaded http://localhost:39788/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39788/tests/dromaeo/cssquery-ext.html) 08:58:45 INFO - PID 12776 | RSS: Main: 188293120 08:58:45 INFO - PID 12776 | 09:00:26 INFO - PID 12776 | ************************* 09:00:26 INFO - PID 12776 | A coding exception was thrown and uncaught in a Task. 09:00:26 INFO - PID 12776 | 09:00:26 ERROR - PID 12776 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:00:26 INFO - PID 12776 | Full stack: 09:00:26 INFO - PID 12776 | ************************* 09:00:26 INFO - PID 12776 | ************************* 09:00:26 INFO - PID 12776 | A coding exception was thrown and uncaught in a Task. 09:00:26 INFO - PID 12776 | 09:00:26 ERROR - PID 12776 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:00:26 INFO - PID 12776 | Full stack: 09:00:26 INFO - PID 12776 | ************************* 09:00:26 INFO - PID 12776 | ************************* 09:00:26 INFO - PID 12776 | A coding exception was thrown and uncaught in a Task. 09:00:26 INFO - PID 12776 | 09:00:26 ERROR - PID 12776 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:00:26 INFO - PID 12776 | Full stack: 09:00:26 INFO - PID 12776 | ************************* 09:00:26 INFO - PID 12776 | ************************* 09:00:26 INFO - PID 12776 | A coding exception was thrown and uncaught in a Task. 09:00:26 INFO - PID 12776 | 09:00:26 ERROR - PID 12776 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:00:26 INFO - PID 12776 | Full stack: 09:00:26 INFO - PID 12776 | ************************* 09:01:47 INFO - PID 12776 | Cycle 1(1): loaded http://localhost:39788/tests/dromaeo/cssquery-ext.html (next: http://localhost:39788/tests/dromaeo/cssquery-jquery.html) 09:01:48 INFO - PID 12776 | RSS: Main: 185798656 09:01:48 INFO - PID 12776 | 09:04:50 INFO - PID 12776 | Cycle 1(1): loaded http://localhost:39788/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39788/tests/dromaeo/cssquery-mootools.html) 09:04:50 INFO - PID 12776 | RSS: Main: 192663552 09:04:50 INFO - PID 12776 | 09:07:52 INFO - PID 12776 | Cycle 1(1): loaded http://localhost:39788/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39788/tests/dromaeo/cssquery-prototype.html) 09:07:53 INFO - PID 12776 | RSS: Main: 187035648 09:07:53 INFO - PID 12776 | 09:10:56 INFO - PID 12776 | Cycle 1(1): loaded http://localhost:39788/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39788/tests/dromaeo/cssquery-yui.html) 09:10:56 INFO - PID 12776 | RSS: Main: 193011712 09:10:56 INFO - PID 12776 | 09:13:59 INFO - PID 12776 | Cycle 1(1): loaded http://localhost:39788/tests/dromaeo/cssquery-yui.html (next: http://localhost:39788/tests/dromaeo/cssquery-dojo.html) 09:13:59 INFO - PID 12776 | RSS: Main: 188252160 09:13:59 INFO - PID 12776 | 09:13:59 INFO - PID 12776 | __start_tp_report 09:13:59 INFO - PID 12776 | _x_x_mozilla_page_load 09:13:59 INFO - PID 12776 | _x_x_mozilla_page_load_details 09:13:59 INFO - PID 12776 | |i|pagename|runs| 09:13:59 INFO - PID 12776 | |0;dojo.html;2789.1074856046066;2802.817816841904;2823.392970511341;2835.149455163451;2840.1905456944774;5325.4142044375185;5436.646617969835;5438.211459338394;5469.398366179717;5491.368492623349;5383.757730902109;5391.676499410039;5429.592780541465;5472.945270547293;5479.808206712766;4544.465873004366;4764.761761911908;4811.855644330676;4832.275158726184;4912.361393018902;4867.659263851532;4871.829485967992;4873.31773551703;4903.877403064934;4922.26166075088;4706.576408123286;4742.976285118552;4810.494898035726;4860.854174374775;4867.050925069613;4772.284157376386;4792.185328494164;4812.446568644581;4827.51724827518;4842.12841688496;4735.289706544011;4781.139394908915;4792.808287668489;4797.664163508556;4844.903101937976;5153.716545589991;5239.502247286502;5251.501107394792;5266.394364648077;5315.654482458628;5791.449812267828;5815.854603634901;5884.941150588482;5902.527797776168;5909.23179986599;5880.323762767293;5892.351841297454;5896.262967129109;5897.233359663259;5899.233099697012;5447.291852059207;5450.645708028966;5455.781768729285;5460.208269800856;5461.672299662033;5882.970585147047;5974.671393073423;5998.310194327621;6052.697365131726;6083.969580152159;5623.297087864017;5639.548836093103;5667.546596272288;5688.431156884279;5707.600467967285;5765.481106700333;5765.942340576625;5796.043652797325;5811.79658711943;5822.737976791054;5780.71096445176;5784.334801497882;5796.5072968797285;5797.449242321973;5797.710114494258;5780;5780.237027706506;5783.479486846204;5790.594658373958;5798.391168927286;4495.100979804052;4506.81972721094;4539.296409056601;4540.931886021713;4574.039451715177;3961.187956468917;3975.2248311578965;3989.2819292527624;4016.718829681894;4024.8188831502653;4877.951220487821;5026.371703537058;5027.3464449621315;5030.874228144326;5040.59675225981;5805.941940580625;5809.622374545641;5884.47039766423;5888.705564721747;5889.440503152194;5013.849584512471;5023.9700861323345;5032.3961124665275;5051.974740126276;5077.339945807095;5210.348706411699;5228.555572776357;5230.137027390514;5243.737813109329;5288.995090932711;5303.204519322133;5358.866028349323;5432;5437.912417516433;5471.9726401369335;5840.853978650568;5863.237779088691;5871.972404829053;5926.970365148147;5943.64338139713;5407.918881216706;5440.047991601533;5445.673259604437;5460.7542660579575;5460.808871689472;5633.690147041788;5665.943340566707;5736.598438109292;5758.3090029196765;5778.046622307273;5817.447342502455;5847.678377689098;5857.238558987305;5872.794452194153;5890.52875769946;5611.466910643482;5677.914831277617;5679.77280908759;5682.318121825408;5688.146777983336;5435;5674;5694.316681998187;5697.059985102577;5699.401562836008;5460.890782184413;5543.362513311021;5557.972210138923;5603;5615.550755939434;5687.687177205294;5709.743061562157;5711.742971566373;5720.628159169641;5725.08398656213;5449.891002180014;5490.615656904138;5559.444055594408;5604.943950560442;5642.689652069175 09:13:59 INFO - PID 12776 | |1;ext.html;728.6283995162468;745.3925051083365;1066.4028144239226;1089.5532831539072;1172.4079339933332;35425.46861797075;36172.28707846912;36234.63765362345;36272;36326;33697.157571060736;33869;33901.321973560574;34047;34078.148046298855;6658.633775142377;6795.93204067958;7160.212376638566;7351.632418379087;7366.410687145042;7335.633218339089;7392.519486233405;7410.333070023697;7419.443541734391;7461.776146715607;7379.778606641809;7418.814529636748;7477.065366829146;7477.1775104738435;7488.475806693534;7389.150247721527;7400.62996850158;7449.180590135081;7452.813679657997;7459.030326057577;7240.891386629205;7270.309320614533;7295.270472952715;7298.927010729878;7326.853462930711;33680.326393471994;33828.58742601172;34022.48966265508;34027.829860850536;34200.65799342;2968.2134234427895;2968.465676178287;2982.642082950038;2987.1038688393614;3001.0996700989617;25823.741762582322;25828.612570811452;25839.483210335875;25882;25920;3176.3806057818733;3225.451673215559;3226.1934516370907;3232.563603913489;3249.951250731241;155729.2213538925;158369;158564;158909;159457.2027139857;41619.79190104091;42095.36856947148;42840;43008.56991430108;43017.35473967893;44638;44821.327680084825;44834;44906.55093449024;45046;13592.728145437233;13636.522721704692;13678.658033549042;13706.588802335946;13740.244286564335;10945;10977.365432296192;10985.725356866142;10996.890031099747;11123.221374503708;13473;13583.320833958263;13631.659208519866;13706.862931370759;13832.723345533233;5349.786008559614;5434.429384914606;5440.211169380497;5508.256385388001;5577.581681373913;878.7100256915203;896.7489103051156;916.4501299220548;923.2890674180977;933.9299552533587;20647.8967605161;21388.572228555342;21447.67828482574;21494.57010859774;21643.13427462884;989.3618615992789;994.8259054665549;999.5052449037628;1000.0649392817738;1014.6702321745462;11300.660980170607;11362.261453005529;11373.31760094397;11408.771824563462;11431;246583;246651;248228.10631362177;248614;248922;42340.3648945266;42395.1520969585;42449.57550424456;42478.57521424746;42529.57470425256;1204.8072308430785;1268.0996492490435;1269.0418733856063;1270.6505710929384;1273.121546133165;19645.50886227856;19876.60246795085;20850.165993360097;20898.268560600307;20921.581568368852;30547.389052219274;30604.234894126934;30605.693943061175;30694.23264418318;30939.535906961864;211144;212148;212377;212648;213102;29992.700072998992;31088.68911310858;31604.209894752814;31710;31725;36509.81745091364;36624.81687591545;36997.445038324986;37691;37762.622373775914;27840.303992400353;28116.156515304574;28156.71843281541;29015.85492072526;29477.26306842346;28463.573046404734;28502.287442814097;28547.28631784139;28780.856095719388;29623.111306660834;31132;31554.684453156093;31637.20906977344;31668.841655791573;31676.841615791775;26943.595846062715;27435.588466173424;27437.45125097447;27785.166445006682;28088;21039.474013149793;22306.665400019338;22903;23081.192158274378;23087.307380778602 09:13:59 INFO - PID 12776 | |2;jquery.html;426.5159044484509;434.9782510874455;439.6263176300145;445.9777011149442;454.3502791008858;17207.827921720764;18367.816321836777;18940.71588926164;18982.43052708421;19089.52276193096;17308.663330450385;18460.53848653781;19423.417297481064;19738.407847764553;19741.40775776729;5263.3683957925;5495.477929596702;5512.862178445551;5521.116621340586;5528.032594295983;5488.423715509874;5520.779168833242;5609.242752228458;5616.157576363557;5627.986962346776;5528.44715528448;5640.097584386499;5648.039833228361;5653.180288858113;5653.321601407837;5465.9726701366235;5524.155060144029;5586.050371436845;5615.0454422748235;5618.971905140468;4978.427480839714;4979.253112033188;4985.800567977277;4999.150144475448;5000.099982003274;22176;22272.329575281918;22285.554288914293;22374.776252237432;22578.887105564532;1654.346533119411;1685.2500637216444;1689.7465380192946;1693.2549678141702;1698.5753561609597;14486.855131448761;14487.565373038826;14999.925000374928;15067.4726384576;15256.084634921941;2025.706272590481;2064.6593312103487;2133.1787261904124;2152.0961196297594;2152.666336717811;91318;91970;92897.53551232268;94169.5291523538;95056.9999999993;11149.554017839358;11177.83233251502;11206.495707693173;11328.546858125748;11528.481218345194;15965.840341596668;15982;15986.120763357894;16043.598910027342;16055.438059667855;7406.629668516553;7482.1021477423055;7590;7693.269139431745;7734.729284475129;6734.730610775514;6783.62690052042;6801.063033168327;7020.894686579705;7042.154941406961;7060.894086588705;7247.130344358605;7248.6738096785775;7260.927390726025;7287.854242915112;2062.329742833585;2075.63676356637;2119.3959721479305;2135.263334149716;2245.2029529517113;841.8947631546057;877.8814859993819;888.1784349476708;889.4352086425166;909.9044600317004;16372.426965056165;16870.746938795928;17237.31050757981;17609.11954402275;17755;875.7197696737111;887.1306120002433;895.4492986813193;919.9126083022102;920.5581320965974;9065.909340906639;9617.51912404377;9644.282869907094;9662.516874156265;9677.758056048655;483371;487376;487807;497947;498422;86398.56800716082;87011.56494217488;87981;89564;90767;1073.0664322039875;1079.519613771864;1104.536094840169;1110.2228440091806;1115.2249186815247;14835.406583736529;17428.651426971643;19302.7104593434;19306.131224095232;19333;43192;44211.77894110509;44766.3285050731;45275;45618;52682.73658631682;53206;53555.698866675724;55113.44886551083;55185.724071380995;8346.12365701617;8466.703665371682;8476.27951624119;8603.311735061305;8856.3800533962;13239.470421183045;13307;13356.465741370237;13473.393697283842;13491.25798081115;10518.684439466828;10556.577736890438;10581.735456613646;10695.518701658288;10922.945385273022;10896.673099807018;10981.725456863642;11017.779644407226;11048.558057677603;11182.66452006441;9848.950755246464;9897.208223341971;9917.206623469961;10276.948615256875;10363.792724145625;8342.196855072816;8524.445911015764;8560.700375486827;8591.269742071994;8713.390062695551;10295.588176472857;10320.43237621908;10341.689749307532;10349.689509314732;10724 09:13:59 INFO - PID 12776 | |3;mootools.html;1248.3259040118337;1371.6707990082384;1375.7523645743763;1378.359063035689;1387.8403983541893;9997.15024222941;10532.947335263312;10553.366797992116;10566.366018038903;10826.404547749871;10574.947125264382;10751.62369317074;10790.73023174419;10815.567377304898;10821.080208182295;2334.894929728162;2366.148186652804;2367.562001029806;2368.751281115484;2372.525494901018;2201.7908298711595;2302.6776251324827;2309.9538009239805;2311.295055008222;2316.339843144704;2212.413710366754;2214.0922221889027;2225.6661500774853;2252.076648574085;2293.483966107629;2040.8571400002006;2167.642339014061;2187.6499760038396;2203.294945617403;2205.2391924786;2170.5441857210003;2172.2180015194517;2180.6728990651527;2183.148572056899;2270.2735124760084;10443.112335451497;10506.264561480699;10534.104601108915;10566.735831604272;10568.313059651175;5722.828315150552;5897.64614123154;5934.258217722785;5949.315828679714;5956.195913551702;3269.362474317509;3382.8646854125805;3442.7590068695204;3486.3201675673254;3489.7906125632544;1115.2304909612424;1188.7028242939266;1191.791436498618;1200.993995030028;1209.9576514822027;15293.623573878293;15414.537563873102;15465.922670386575;15514.146721930289;15523.06861588297;4811.807527698923;4950.297616080236;5176;5228.869278268074;5260.9736951315;11383.487743051583;11403.657890263305;11438.428078596036;11451.312921224753;11454.083673306282;5683.715814209273;5751.9424805751405;5766.365699773021;5798.8550286242335;5818.738156782955;5181.766820493087;5186.170212765939;5225.895482090413;5226.085435048852;5309.309789727311;3989.9002524936527;4078.816453259551;4104.138130992465;4176.937345939813;4196.727212731163;1195.5576436718295;1198.1972078707288;1209.7096696792707;1222.834917286155;1228.4778968938165;694.8888177891513;698.2703075286338;715.2775696546421;725.1805459830358;739.7299985505252;5261.894762104736;5270.973645131749;5368.275282836845;6271.529635277372;6346.9682651586445;834;837.5686521441462;839.1943734015291;849.7535714642808;884.5090974509209;3683.189698266377;3712.3317802795755;3717.7211709121384;3784.243151369737;3795.3320295049334;13333.866661333263;13832.93083534596;13870.722585548232;13896.722065558632;13927.442902283998;13629.727405451835;13639.590812275648;13679.042467027411;13681.589552313446;13701.725965480635;9740.75648108803;9787.36382135159;9795.9020409795;9917.454540000224;9949.452780097165;5755;5801.6519008859605;5878.676672783038;6083.66539840313;6085.6348619083;12148.21036632616;12351.876481235433;12404.379781011094;12405.131640785059;12470.438830252479;12536.185147965352;12552.623421297376;12650.493980240688;12710.428030738454;12729.80905286403;7695.23047695226;7756.108047574376;7796.805079872822;7843.058832939855;7871.606419679108;9340.486273254764;9448.196903263299;9454.810903782023;9455.621775129193;9456;8002.919970800217;8116.878246826184;8119.5534245617055;8155.469894456842;8281.21328473794;8142.226488483585;8190.344772418312;8228.21831925966;8270.214329638675;8459;7264.636768161465;7292.890606641011;7385.889211661937;7420.40636749048;7429.405647548075;4152.979235103805;5012.799488020439;5042.672226305279;5102.897942041212;5155.742212889266;5025.680840898308;5052.5705315048635;5085.4406015337545;5089;5104.69371837691 09:13:59 INFO - PID 12776 | |4;prototype.html;393.47471126046725;394.40641834039747;405.541737836245;407.912298855746;409.59100693613976;5373.247745315659;5498.3127109111365;5534.584906132036;5545.528630066439;5568.1091025435935;5308.362996440433;5416.07926652469;5418.756155972981;5419.430959749228;5425.9728701356435;4041.9595804042024;4145.7719825409595;4148.294789885712;4153.979230103845;4159.480064991876;4147.668186545069;4152.68854835887;4153.9199808049825;4154.356074808409;4163.208990291835;4116.300228961069;4119.608637179464;4137.565555616647;4141.275276826558;4152.107296931159;3929.941050884239;4085.407615895708;4142.502899652046;4143.585641435862;4144.772037537934;3607.7474576779637;3613.241219343941;3614.6023937366867;3617.7105831533413;3624.855005799765;5160.406553246387;5220.843374698765;5228.895422091575;5244.318238628992;5256.58197229275;4579.587837094644;4866.712645056818;4880.341153944243;4884.731339776311;4904.8773780655765;5678.375378708339;5709.857253568694;5723.284589426322;5726.885462290773;5750.712464376807;3980.4626375439234;3981.402789581586;3983.5817239190046;3987.182627561343;3990.5610382857863;5583.469570390806;6001.849953751192;6022.548308876808;6094.603850749687;6117.776444711031;4131.318332475168;4170.374443833449;4172.395002724588;4183.91632167355;4184.790760462026;4236.872893813191;4241.554636763095;4247.685011668648;4251.341042138473;4269.5090064642345;4770.284457331428;4813.518648135158;4874.074740477491;4875.7074575524875;4903.877403064952;5777.768889244383;5777.855553611109;5793.536517078624;5801.419858014165;5810.941890581124;1447.9710405791825;1465.377214683755;1469.0671423645847;1471.1687896338535;1474.4397129091092;953.68051702679;985.7831277119022;988.8368419210893;990.3612170150212;1011.5181259454934;5041.697498150123;5060.645754797202;5065.721385323769;5069.8732531687;5083.288339632454;5992.790252341147;6015.105241848803;6017.277926648742;6032.819015429544;6033.159886234653;4852.51474852519;5018.924716129261;5021.72380519075;5060.316857224301;5080.847574572768;3150.7239567975007;3161.9051428456723;3166.60417447819;3167.9683203168133;3175.7935734177204;5542.2795036644975;5564.443555644403;5576.7211639417865;5580.91628625571;5582.469665381782;5863.208466857005;5869.356580157562;6001.969990150022;6013.338532761392;6158.969205153946;5476.315460567429;5557.527610153183;5558.166275058774;5586.916196256978;5611.579131565068;5972.343042265435;5989.580729348903;6009.278886533469;6009.759609615567;6015.819525414245;5726.398728133486;5876.1773351731645;5923;5952.821415357546;5954.46409823118;5571.415001424954;5598.916016259841;5601.41185175567;5610.4670056344585;5612;4061.4923134608175;4165.083681590046;4184.330507118846;4200.075983283673;4212.705110642348;5984.760609575568;6000.969995149996;6017.849553761016;6035.969820150871;6045.304789949212;5782.277215348082;5785.82642520725;5797.768089276382;5798;5824.592278540462;5542.612017158922;5737.655740655574;5765.538756899354;5784.768609255582;5802.65184088956;5653.773849045992;5667.2349232854685;5691.3170419549915;5704.857378565569;5713.8285851424525;5751.223584815996;5855.795047173328;5864.012471519408;5865.120231965239;5872.823815285548;5675.77296908119;5711.228984087095;5714.4856612996755;5727.5417966561745;5733.283339582552 09:13:59 INFO - PID 12776 | |5;yui.html;731.4879584290994;735.724103461202;758.4728613613537;764.5221736414741;769.5998080997881;13324.333783310844;13674.111182773113;13839.238841863693;14372.640683982905;14387.42450301988;12974.61076167714;13051.086423950328;13314.533991310305;13340.666483337896;13424.9931255156;828.7099515169702;855.0338117926734;855.7603870916122;855.8331125430543;858.3519442820661;878.9736307910773;910.8497097978826;914.7621618379236;920.7099763574453;921.4195057114009;961.0437614573509;968.4528241543505;969.7866469376726;972.2756546372962;974.9415035097882;953.1707414549317;959.2374062620199;964.430985718426;966.6181858166055;969.6170012844887;704.8061783009662;711.779348401997;715.8783006888841;716.029779648579;718.56526801285;13704;14104.506342278073;15028.849711502855;15041.871859610463;15106.622334441618;13961.581152565337;14792.55622331321;14823.407063717439;14860.851391486054;14888.181150036744;11974.940125299405;12260.938695306466;12261.632151035483;12345.321007344592;12447;2863.599096126544;2892.3781387001895;2907.825530468179;2910.767138628905;2919.7372236498604;67325;68089.31910680879;68855.65572172106;68886;70252.29747702509;10763.946180269206;10896.18278629106;11044.723881903017;11125.72185695348;11487.770244595062;22180;22280.888595556917;22288.219912302993;22614.886925565268;22750.886245568665;6206.751729930752;6394.360563943568;6399.232092148972;6499.155109835691;6511.902321465182;3353.2119951811305;3389.5424117743787;3427.5715535558056;3448.77582957107;3460.3598334308235;3575.4279315309427;3660.926781464409;3665.2119794244363;3681.650243226889;3730.9067273318383;725.9201487836334;731.5171986488892;746.2574738135589;749.2020997637608;749.5427789048676;610.7251736718495;612.2713970375239;629.754395785644;630.2877748144659;639.6961443314389;8225.71210007647;8823.955880220557;9084.772880678036;9179.219766319804;9244.306676999251;594.7918228620035;609.9756009759649;612.3631423319787;622.0731110645106;625.1872565664618;4013.8595149169637;4028.436018957348;4112.958870411318;4151.605597468236;4210.45264115663;61191.6940415304;61833.69083154645;61947;63930;66905;52917;53102;53329.733351332994;54041.729791350794;55803.441965580634;48472.5152748468;49123;49145.23933298682;49864.50135498599;51065.234021489705;8459.83080338402;8845.24815390699;8928.15182557656;8935.151160639729;8954.417962832395;25785.613215802154;26140.8692956534;26897.596536052366;26979.730202697723;27087;32123.196920077185;32135.51796723098;32227.838860806485;32342.514862277556;33240.33519329551;11320.433978301216;11366.798139108201;11633.360165190996;11813.527458901548;12064.698382540506;12985.415656295301;13370.390442050222;13379.063465557318;13408.530701425403;13483.393247303698;11903.166778325434;11967.700807479883;11970.22193557416;12078;12384.56654017105;11564.421778910853;11656;11814.881851181379;11909;11950.223235489666;12074.45664945062;12081.637550873487;12239.87760122423;12249.387530623611;12329.445174967328;8298.917010829815;8345.082040975609;8411.70559030431;8784.868226976729;8932.330075244512;8996.325275604488;9661.46861922601;10043.196544276587;10239.436830974368;10240.846387304047 09:13:59 INFO - PID 12776 | __end_tp_report 09:13:59 INFO - PID 12776 | __start_cc_report 09:13:59 INFO - PID 12776 | _x_x_mozilla_cycle_collect,379 09:13:59 INFO - PID 12776 | __end_cc_report 09:13:59 INFO - PID 12776 | __startTimestamp1491408839644__endTimestamp 09:13:59 INFO - PID 12776 | 09:13:59 INFO - PID 12776 | ------- Summary: start ------- 09:13:59 INFO - PID 12776 | Number of tests: 6 09:13:59 INFO - PID 12776 | 09:13:59 INFO - PID 12776 | [#0] dojo.html Cycles:165 Average:5312.70 Median:5461.67 stddev:645.71 (11.8%) stddev-sans-first:616.60 09:13:59 INFO - PID 12776 | Values: 2789.1 2802.8 2823.4 2835.1 2840.2 5325.4 5436.6 5438.2 5469.4 5491.4 5383.8 5391.7 5429.6 5472.9 5479.8 4544.5 4764.8 4811.9 4832.3 4912.4 4867.7 4871.8 4873.3 4903.9 4922.3 4706.6 4743.0 4810.5 4860.9 4867.1 4772.3 4792.2 4812.4 4827.5 4842.1 4735.3 4781.1 4792.8 4797.7 4844.9 5153.7 5239.5 5251.5 5266.4 5315.7 5791.4 5815.9 5884.9 5902.5 5909.2 5880.3 5892.4 5896.3 5897.2 5899.2 5447.3 5450.6 5455.8 5460.2 5461.7 5883.0 5974.7 5998.3 6052.7 6084.0 5623.3 5639.5 5667.5 5688.4 5707.6 5765.5 5765.9 5796.0 5811.8 5822.7 5780.7 5784.3 5796.5 5797.4 5797.7 5780.0 5780.2 5783.5 5790.6 5798.4 4495.1 4506.8 4539.3 4540.9 4574.0 3961.2 3975.2 3989.3 4016.7 4024.8 4878.0 5026.4 5027.3 5030.9 5040.6 5805.9 5809.6 5884.5 5888.7 5889.4 5013.8 5024.0 5032.4 5052.0 5077.3 5210.3 5228.6 5230.1 5243.7 5289.0 5303.2 5358.9 5432.0 5437.9 5472.0 5840.9 5863.2 5872.0 5927.0 5943.6 5407.9 5440.0 5445.7 5460.8 5460.8 5633.7 5665.9 5736.6 5758.3 5778.0 5817.4 5847.7 5857.2 5872.8 5890.5 5611.5 5677.9 5679.8 5682.3 5688.1 5435.0 5674.0 5694.3 5697.1 5699.4 5460.9 5543.4 5558.0 5603.0 5615.6 5687.7 5709.7 5711.7 5720.6 5725.1 5449.9 5490.6 5559.4 5604.9 5642.7 09:13:59 INFO - PID 12776 | 09:13:59 INFO - PID 12776 | [#1] ext.html Cycles:180 Average:34991.01 Median:31014.11 stddev:54499.56 (175.7%) stddev-sans-first:54591.72 09:13:59 INFO - PID 12776 | Values: 728.6 745.4 1066.4 1089.6 1172.4 35425.5 36172.3 36234.6 36272.0 36326.0 33697.2 33869.0 33901.3 34047.0 34078.1 6658.6 6795.9 7160.2 7351.6 7366.4 7335.6 7392.5 7410.3 7419.4 7461.8 7379.8 7418.8 7477.1 7477.2 7488.5 7389.2 7400.6 7449.2 7452.8 7459.0 7240.9 7270.3 7295.3 7298.9 7326.9 33680.3 33828.6 34022.5 34027.8 34200.7 2968.2 2968.5 2982.6 2987.1 3001.1 25823.7 25828.6 25839.5 25882.0 25920.0 3176.4 3225.5 3226.2 3232.6 3250.0 155729.2 158369.0 158564.0 158909.0 159457.2 41619.8 42095.4 42840.0 43008.6 43017.4 44638.0 44821.3 44834.0 44906.6 45046.0 13592.7 13636.5 13678.7 13706.6 13740.2 10945.0 10977.4 10985.7 10996.9 11123.2 13473.0 13583.3 13631.7 13706.9 13832.7 5349.8 5434.4 5440.2 5508.3 5577.6 878.7 896.7 916.5 923.3 933.9 20647.9 21388.6 21447.7 21494.6 21643.1 989.4 994.8 999.5 1000.1 1014.7 11300.7 11362.3 11373.3 11408.8 11431.0 246583.0 246651.0 248228.1 248614.0 248922.0 42340.4 42395.2 42449.6 42478.6 42529.6 1204.8 1268.1 1269.0 1270.7 1273.1 19645.5 19876.6 20850.2 20898.3 20921.6 30547.4 30604.2 30605.7 30694.2 30939.5 211144.0 212148.0 212377.0 212648.0 213102.0 29992.7 31088.7 31604.2 31710.0 31725.0 36509.8 36624.8 36997.4 37691.0 37762.6 27840.3 28116.2 28156.7 29015.9 29477.3 28463.6 28502.3 28547.3 28780.9 29623.1 31132.0 31554.7 31637.2 31668.8 31676.8 26943.6 27435.6 27437.5 27785.2 28088.0 21039.5 22306.7 22903.0 23081.2 23087.3 09:13:59 INFO - PID 12776 | 09:13:59 INFO - PID 12776 | [#2] jquery.html Cycles:180 Average:29122.06 Median:23036.18 stddev:81116.18 (352.1%) stddev-sans-first:81315.12 09:13:59 INFO - PID 12776 | Values: 426.5 435.0 439.6 446.0 454.4 17207.8 18367.8 18940.7 18982.4 19089.5 17308.7 18460.5 19423.4 19738.4 19741.4 5263.4 5495.5 5512.9 5521.1 5528.0 5488.4 5520.8 5609.2 5616.2 5628.0 5528.4 5640.1 5648.0 5653.2 5653.3 5466.0 5524.2 5586.1 5615.0 5619.0 4978.4 4979.3 4985.8 4999.2 5000.1 22176.0 22272.3 22285.6 22374.8 22578.9 1654.3 1685.3 1689.7 1693.3 1698.6 14486.9 14487.6 14999.9 15067.5 15256.1 2025.7 2064.7 2133.2 2152.1 2152.7 91318.0 91970.0 92897.5 94169.5 95057.0 11149.6 11177.8 11206.5 11328.5 11528.5 15965.8 15982.0 15986.1 16043.6 16055.4 7406.6 7482.1 7590.0 7693.3 7734.7 6734.7 6783.6 6801.1 7020.9 7042.2 7060.9 7247.1 7248.7 7260.9 7287.9 2062.3 2075.6 2119.4 2135.3 2245.2 841.9 877.9 888.2 889.4 909.9 16372.4 16870.7 17237.3 17609.1 17755.0 875.7 887.1 895.4 919.9 920.6 9065.9 9617.5 9644.3 9662.5 9677.8 483371.0 487376.0 487807.0 497947.0 498422.0 86398.6 87011.6 87981.0 89564.0 90767.0 1073.1 1079.5 1104.5 1110.2 1115.2 14835.4 17428.7 19302.7 19306.1 19333.0 43192.0 44211.8 44766.3 45275.0 45618.0 52682.7 53206.0 53555.7 55113.4 55185.7 8346.1 8466.7 8476.3 8603.3 8856.4 13239.5 13307.0 13356.5 13473.4 13491.3 10518.7 10556.6 10581.7 10695.5 10922.9 10896.7 10981.7 11017.8 11048.6 11182.7 9849.0 9897.2 9917.2 10276.9 10363.8 8342.2 8524.4 8560.7 8591.3 8713.4 10295.6 10320.4 10341.7 10349.7 10724.0 09:13:59 INFO - PID 12776 | 09:13:59 INFO - PID 12776 | [#3] mootools.html Cycles:180 Average:6479.34 Median:3715.03 stddev:4197.38 (113.0%) stddev-sans-first:4190.75 09:13:59 INFO - PID 12776 | Values: 1248.3 1371.7 1375.8 1378.4 1387.8 9997.2 10532.9 10553.4 10566.4 10826.4 10574.9 10751.6 10790.7 10815.6 10821.1 2334.9 2366.1 2367.6 2368.8 2372.5 2201.8 2302.7 2310.0 2311.3 2316.3 2212.4 2214.1 2225.7 2252.1 2293.5 2040.9 2167.6 2187.6 2203.3 2205.2 2170.5 2172.2 2180.7 2183.1 2270.3 10443.1 10506.3 10534.1 10566.7 10568.3 5722.8 5897.6 5934.3 5949.3 5956.2 3269.4 3382.9 3442.8 3486.3 3489.8 1115.2 1188.7 1191.8 1201.0 1210.0 15293.6 15414.5 15465.9 15514.1 15523.1 4811.8 4950.3 5176.0 5228.9 5261.0 11383.5 11403.7 11438.4 11451.3 11454.1 5683.7 5751.9 5766.4 5798.9 5818.7 5181.8 5186.2 5225.9 5226.1 5309.3 3989.9 4078.8 4104.1 4176.9 4196.7 1195.6 1198.2 1209.7 1222.8 1228.5 694.9 698.3 715.3 725.2 739.7 5261.9 5271.0 5368.3 6271.5 6347.0 834.0 837.6 839.2 849.8 884.5 3683.2 3712.3 3717.7 3784.2 3795.3 13333.9 13832.9 13870.7 13896.7 13927.4 13629.7 13639.6 13679.0 13681.6 13701.7 9740.8 9787.4 9795.9 9917.5 9949.5 5755.0 5801.7 5878.7 6083.7 6085.6 12148.2 12351.9 12404.4 12405.1 12470.4 12536.2 12552.6 12650.5 12710.4 12729.8 7695.2 7756.1 7796.8 7843.1 7871.6 9340.5 9448.2 9454.8 9455.6 9456.0 8002.9 8116.9 8119.6 8155.5 8281.2 8142.2 8190.3 8228.2 8270.2 8459.0 7264.6 7292.9 7385.9 7420.4 7429.4 4153.0 5012.8 5042.7 5102.9 5155.7 5025.7 5052.6 5085.4 5089.0 5104.7 09:13:59 INFO - PID 12776 | 09:13:59 INFO - PID 12776 | [#4] prototype.html Cycles:180 Average:4762.27 Median:5422.70 stddev:1402.37 (25.9%) stddev-sans-first:1367.43 09:13:59 INFO - PID 12776 | Values: 393.5 394.4 405.5 407.9 409.6 5373.2 5498.3 5534.6 5545.5 5568.1 5308.4 5416.1 5418.8 5419.4 5426.0 4042.0 4145.8 4148.3 4154.0 4159.5 4147.7 4152.7 4153.9 4154.4 4163.2 4116.3 4119.6 4137.6 4141.3 4152.1 3929.9 4085.4 4142.5 4143.6 4144.8 3607.7 3613.2 3614.6 3617.7 3624.9 5160.4 5220.8 5228.9 5244.3 5256.6 4579.6 4866.7 4880.3 4884.7 4904.9 5678.4 5709.9 5723.3 5726.9 5750.7 3980.5 3981.4 3983.6 3987.2 3990.6 5583.5 6001.8 6022.5 6094.6 6117.8 4131.3 4170.4 4172.4 4183.9 4184.8 4236.9 4241.6 4247.7 4251.3 4269.5 4770.3 4813.5 4874.1 4875.7 4903.9 5777.8 5777.9 5793.5 5801.4 5810.9 1448.0 1465.4 1469.1 1471.2 1474.4 953.7 985.8 988.8 990.4 1011.5 5041.7 5060.6 5065.7 5069.9 5083.3 5992.8 6015.1 6017.3 6032.8 6033.2 4852.5 5018.9 5021.7 5060.3 5080.8 3150.7 3161.9 3166.6 3168.0 3175.8 5542.3 5564.4 5576.7 5580.9 5582.5 5863.2 5869.4 6002.0 6013.3 6159.0 5476.3 5557.5 5558.2 5586.9 5611.6 5972.3 5989.6 6009.3 6009.8 6015.8 5726.4 5876.2 5923.0 5952.8 5954.5 5571.4 5598.9 5601.4 5610.5 5612.0 4061.5 4165.1 4184.3 4200.1 4212.7 5984.8 6001.0 6017.8 6036.0 6045.3 5782.3 5785.8 5797.8 5798.0 5824.6 5542.6 5737.7 5765.5 5784.8 5802.7 5653.8 5667.2 5691.3 5704.9 5713.8 5751.2 5855.8 5864.0 5865.1 5872.8 5675.8 5711.2 5714.5 5727.5 5733.3 09:13:59 INFO - PID 12776 | 09:13:59 INFO - PID 12776 | [#5] yui.html Cycles:180 Average:14475.03 Median:4132.28 stddev:17548.36 (424.7%) stddev-sans-first:17567.24 09:13:59 INFO - PID 12776 | Values: 731.5 735.7 758.5 764.5 769.6 13324.3 13674.1 13839.2 14372.6 14387.4 12974.6 13051.1 13314.5 13340.7 13425.0 828.7 855.0 855.8 855.8 858.4 879.0 910.8 914.8 920.7 921.4 961.0 968.5 969.8 972.3 974.9 953.2 959.2 964.4 966.6 969.6 704.8 711.8 715.9 716.0 718.6 13704.0 14104.5 15028.8 15041.9 15106.6 13961.6 14792.6 14823.4 14860.9 14888.2 11974.9 12260.9 12261.6 12345.3 12447.0 2863.6 2892.4 2907.8 2910.8 2919.7 67325.0 68089.3 68855.7 68886.0 70252.3 10763.9 10896.2 11044.7 11125.7 11487.8 22180.0 22280.9 22288.2 22614.9 22750.9 6206.8 6394.4 6399.2 6499.2 6511.9 3353.2 3389.5 3427.6 3448.8 3460.4 3575.4 3660.9 3665.2 3681.7 3730.9 725.9 731.5 746.3 749.2 749.5 610.7 612.3 629.8 630.3 639.7 8225.7 8824.0 9084.8 9179.2 9244.3 594.8 610.0 612.4 622.1 625.2 4013.9 4028.4 4113.0 4151.6 4210.5 61191.7 61833.7 61947.0 63930.0 66905.0 52917.0 53102.0 53329.7 54041.7 55803.4 48472.5 49123.0 49145.2 49864.5 51065.2 8459.8 8845.2 8928.2 8935.2 8954.4 25785.6 26140.9 26897.6 26979.7 27087.0 32123.2 32135.5 32227.8 32342.5 33240.3 11320.4 11366.8 11633.4 11813.5 12064.7 12985.4 13370.4 13379.1 13408.5 13483.4 11903.2 11967.7 11970.2 12078.0 12384.6 11564.4 11656.0 11814.9 11909.0 11950.2 12074.5 12081.6 12239.9 12249.4 12329.4 8298.9 8345.1 8411.7 8784.9 8932.3 8996.3 9661.5 10043.2 10239.4 10240.8 09:13:59 INFO - PID 12776 | -------- Summary: end -------- 09:13:59 INFO - PID 12776 | 09:14:00 INFO - TEST-INFO | 12776: exit 0 09:14:00 INFO - TEST-OK | dromaeo_css | took 1121761ms 09:14:00 INFO - TEST-START | kraken 09:14:00 INFO - operating with platform_type : linux_ 09:14:00 INFO - Initialising browser for kraken test... 09:14:00 INFO - TEST-INFO | started process 13169 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy1xKtk/profile http://localhost:39788/getInfo.html) 09:14:05 INFO - PID 13169 | __metrics Screen width/height:1600/1200 09:14:05 INFO - PID 13169 | colorDepth:24 09:14:05 INFO - PID 13169 | Browser inner width/height: 1024/697 09:14:05 INFO - PID 13169 | __metrics 09:14:06 ERROR - PID 13169 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 09:14:07 INFO - TEST-INFO | 13169: exit 0 09:14:07 INFO - Browser initialized. 09:14:07 INFO - Running cycle 1/1 for kraken test... 09:14:07 INFO - TEST-INFO | started process 13313 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy1xKtk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:14:20 INFO - PID 13313 | RSS: Main: 178401280 09:14:20 INFO - PID 13313 | 09:14:22 INFO - PID 13313 | Cycle 1(1): loaded http://localhost:39788/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39788/tests/kraken/driver.html?testName=audio-beat-detection) 09:14:23 INFO - PID 13313 | RSS: Main: 186101760 09:14:23 INFO - PID 13313 | 09:14:26 INFO - PID 13313 | Cycle 1(1): loaded http://localhost:39788/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39788/tests/kraken/driver.html?testName=audio-dft) 09:14:27 INFO - PID 13313 | RSS: Main: 185593856 09:14:27 INFO - PID 13313 | 09:14:30 INFO - PID 13313 | Cycle 1(1): loaded http://localhost:39788/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39788/tests/kraken/driver.html?testName=audio-fft) 09:14:30 INFO - PID 13313 | RSS: Main: 182734848 09:14:30 INFO - PID 13313 | 09:14:32 INFO - PID 13313 | Cycle 1(1): loaded http://localhost:39788/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39788/tests/kraken/driver.html?testName=audio-oscillator) 09:14:33 INFO - PID 13313 | RSS: Main: 184201216 09:14:33 INFO - PID 13313 | 09:14:35 INFO - PID 13313 | Cycle 1(1): loaded http://localhost:39788/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39788/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:14:36 INFO - PID 13313 | RSS: Main: 184754176 09:14:36 INFO - PID 13313 | 09:14:39 INFO - PID 13313 | Cycle 1(1): loaded http://localhost:39788/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39788/tests/kraken/driver.html?testName=imaging-darkroom) 09:14:40 INFO - PID 13313 | RSS: Main: 187985920 09:14:40 INFO - PID 13313 | 09:14:43 INFO - PID 13313 | Cycle 1(1): loaded http://localhost:39788/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39788/tests/kraken/driver.html?testName=imaging-desaturate) 09:14:44 INFO - PID 13313 | RSS: Main: 186912768 09:14:44 INFO - PID 13313 | 09:14:47 INFO - PID 13313 | Cycle 1(1): loaded http://localhost:39788/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39788/tests/kraken/driver.html?testName=json-parse-financial) 09:14:48 INFO - PID 13313 | RSS: Main: 187514880 09:14:48 INFO - PID 13313 | 09:14:49 INFO - PID 13313 | Cycle 1(1): loaded http://localhost:39788/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39788/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:14:50 INFO - PID 13313 | RSS: Main: 188030976 09:14:50 INFO - PID 13313 | 09:14:52 INFO - PID 13313 | Cycle 1(1): loaded http://localhost:39788/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39788/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:14:52 INFO - PID 13313 | RSS: Main: 188862464 09:14:52 INFO - PID 13313 | 09:14:54 INFO - PID 13313 | Cycle 1(1): loaded http://localhost:39788/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39788/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:14:55 INFO - PID 13313 | RSS: Main: 188837888 09:14:55 INFO - PID 13313 | 09:14:58 INFO - PID 13313 | Cycle 1(1): loaded http://localhost:39788/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39788/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:14:59 INFO - PID 13313 | RSS: Main: 188624896 09:14:59 INFO - PID 13313 | 09:15:02 INFO - PID 13313 | Cycle 1(1): loaded http://localhost:39788/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39788/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:15:03 INFO - PID 13313 | RSS: Main: 186556416 09:15:03 INFO - PID 13313 | 09:15:04 INFO - PID 13313 | Cycle 1(1): loaded http://localhost:39788/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39788/tests/kraken/driver.html?testName=ai-astar) 09:15:05 INFO - PID 13313 | RSS: Main: 188731392 09:15:05 INFO - PID 13313 | 09:15:05 INFO - PID 13313 | __start_tp_report 09:15:05 INFO - PID 13313 | _x_x_mozilla_page_load 09:15:05 INFO - PID 13313 | _x_x_mozilla_page_load_details 09:15:05 INFO - PID 13313 | |i|pagename|runs| 09:15:05 INFO - PID 13313 | |0;ai-astar;106;112;110;111;111;110;112;113;110;110 09:15:05 INFO - PID 13313 | |1;audio-beat-detection;151;124;123;185;130;122;126;123;155;123 09:15:05 INFO - PID 13313 | |2;audio-dft;165;166;166;170;166;175;167;164;166;165 09:15:05 INFO - PID 13313 | |3;audio-fft;75;76;75;105;79;77;77;75;94;78 09:15:05 INFO - PID 13313 | |4;audio-oscillator;84;85;103;84;85;84;104;84;89;105 09:15:05 INFO - PID 13313 | |5;imaging-gaussian-blur;114;114;115;114;114;115;115;115;118;124 09:15:05 INFO - PID 13313 | |6;imaging-darkroom;151;150;151;152;152;151;151;152;156;151 09:15:05 INFO - PID 13313 | |7;imaging-desaturate;96;96;95;94;95;95;94;95;95;96 09:15:05 INFO - PID 13313 | |8;json-parse-financial;54;53;56;53;55;55;54;55;55;54 09:15:05 INFO - PID 13313 | |9;json-stringify-tinderbox;56;55;58;56;56;55;56;58;55;55 09:15:05 INFO - PID 13313 | |10;stanford-crypto-aes;85;81;83;87;82;83;82;83;82;81 09:15:05 INFO - PID 13313 | |11;stanford-crypto-ccm;146;142;143;151;136;150;134;138;185;144 09:15:05 INFO - PID 13313 | |12;stanford-crypto-pbkdf2;189;201;202;191;197;209;199;212;201;190 09:15:05 INFO - PID 13313 | |13;stanford-crypto-sha256-iterative;70;71;73;76;73;75;71;72;71;73 09:15:05 INFO - PID 13313 | __end_tp_report 09:15:05 INFO - PID 13313 | __start_cc_report 09:15:05 INFO - PID 13313 | _x_x_mozilla_cycle_collect,884 09:15:05 INFO - PID 13313 | __end_cc_report 09:15:05 INFO - PID 13313 | __startTimestamp1491408905204__endTimestamp 09:15:05 INFO - PID 13313 | 09:15:05 INFO - PID 13313 | ------- Summary: start ------- 09:15:05 INFO - PID 13313 | Number of tests: 14 09:15:05 INFO - PID 13313 | 09:15:05 INFO - PID 13313 | [#0] ai-astar Cycles:10 Average:110.50 Median:111.00 stddev:1.90 (1.7%) stddev-sans-first:1.12 09:15:05 INFO - PID 13313 | Values: 106.0 112.0 110.0 111.0 111.0 110.0 112.0 113.0 110.0 110.0 09:15:05 INFO - PID 13313 | 09:15:05 INFO - PID 13313 | [#1] audio-beat-detection Cycles:10 Average:136.20 Median:128.00 stddev:21.00 (16.4%) stddev-sans-first:21.58 09:15:05 INFO - PID 13313 | Values: 151.0 124.0 123.0 185.0 130.0 122.0 126.0 123.0 155.0 123.0 09:15:05 INFO - PID 13313 | 09:15:05 INFO - PID 13313 | [#2] audio-dft Cycles:10 Average:167.00 Median:166.00 stddev:3.23 (1.9%) stddev-sans-first:3.35 09:15:05 INFO - PID 13313 | Values: 165.0 166.0 166.0 170.0 166.0 175.0 167.0 164.0 166.0 165.0 09:15:05 INFO - PID 13313 | 09:15:05 INFO - PID 13313 | [#3] audio-fft Cycles:10 Average:81.10 Median:77.00 stddev:10.13 (13.2%) stddev-sans-first:10.50 09:15:05 INFO - PID 13313 | Values: 75.0 76.0 75.0 105.0 79.0 77.0 77.0 75.0 94.0 78.0 09:15:05 INFO - PID 13313 | 09:15:05 INFO - PID 13313 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:84.00 stddev:9.31 (11.1%) stddev-sans-first:9.55 09:15:05 INFO - PID 13313 | Values: 84.0 85.0 103.0 84.0 85.0 84.0 104.0 84.0 89.0 105.0 09:15:05 INFO - PID 13313 | 09:15:05 INFO - PID 13313 | [#5] imaging-gaussian-blur Cycles:10 Average:115.80 Median:115.00 stddev:3.12 (2.7%) stddev-sans-first:3.24 09:15:05 INFO - PID 13313 | Values: 114.0 114.0 115.0 114.0 114.0 115.0 115.0 115.0 118.0 124.0 09:15:05 INFO - PID 13313 | 09:15:05 INFO - PID 13313 | [#6] imaging-darkroom Cycles:10 Average:151.70 Median:151.50 stddev:1.64 (1.1%) stddev-sans-first:1.72 09:15:05 INFO - PID 13313 | Values: 151.0 150.0 151.0 152.0 152.0 151.0 151.0 152.0 156.0 151.0 09:15:05 INFO - PID 13313 | 09:15:05 INFO - PID 13313 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.74 (0.8%) stddev-sans-first:0.71 09:15:05 INFO - PID 13313 | Values: 96.0 96.0 95.0 94.0 95.0 95.0 94.0 95.0 95.0 96.0 09:15:05 INFO - PID 13313 | 09:15:05 INFO - PID 13313 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:0.97 (1.8%) stddev-sans-first:1.01 09:15:05 INFO - PID 13313 | Values: 54.0 53.0 56.0 53.0 55.0 55.0 54.0 55.0 55.0 54.0 09:15:05 INFO - PID 13313 | 09:15:05 INFO - PID 13313 | [#9] json-stringify-tinderbox Cycles:10 Average:56.00 Median:56.00 stddev:1.15 (2.1%) stddev-sans-first:1.22 09:15:05 INFO - PID 13313 | Values: 56.0 55.0 58.0 56.0 56.0 55.0 56.0 58.0 55.0 55.0 09:15:05 INFO - PID 13313 | 09:15:05 INFO - PID 13313 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:1.85 (2.2%) stddev-sans-first:1.80 09:15:05 INFO - PID 13313 | Values: 85.0 81.0 83.0 87.0 82.0 83.0 82.0 83.0 82.0 81.0 09:15:05 INFO - PID 13313 | 09:15:05 INFO - PID 13313 | [#11] stanford-crypto-ccm Cycles:10 Average:146.90 Median:145.00 stddev:14.49 (10.0%) stddev-sans-first:15.37 09:15:05 INFO - PID 13313 | Values: 146.0 142.0 143.0 151.0 136.0 150.0 134.0 138.0 185.0 144.0 09:15:05 INFO - PID 13313 | 09:15:05 INFO - PID 13313 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:199.10 Median:201.00 stddev:7.71 (3.8%) stddev-sans-first:7.26 09:15:05 INFO - PID 13313 | Values: 189.0 201.0 202.0 191.0 197.0 209.0 199.0 212.0 201.0 190.0 09:15:05 INFO - PID 13313 | 09:15:05 INFO - PID 13313 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:73.00 stddev:1.90 (2.6%) stddev-sans-first:1.79 09:15:05 INFO - PID 13313 | Values: 70.0 71.0 73.0 76.0 73.0 75.0 71.0 72.0 71.0 73.0 09:15:05 INFO - PID 13313 | -------- Summary: end -------- 09:15:05 INFO - PID 13313 | 09:15:06 INFO - TEST-INFO | 13313: exit 0 09:15:06 INFO - TEST-OK | kraken | took 65986ms 09:15:06 INFO - SUITE-END | took 1187s 09:15:06 INFO - Completed test suite (00:19:48) 09:15:06 INFO - javascript benchmark 09:15:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6835.702037360314, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2789.1074856046066, 2802.817816841904, 2823.392970511341, 2835.149455163451, 2840.1905456944774, 5325.4142044375185, 5436.646617969835, 5438.211459338394, 5469.398366179717, 5491.368492623349, 5383.757730902109, 5391.676499410039, 5429.592780541465, 5472.945270547293, 5479.808206712766, 4544.465873004366, 4764.761761911908, 4811.855644330676, 4832.275158726184, 4912.361393018902, 4867.659263851532, 4871.829485967992, 4873.31773551703, 4903.877403064934, 4922.26166075088, 4706.576408123286, 4742.976285118552, 4810.494898035726, 4860.854174374775, 4867.050925069613, 4772.284157376386, 4792.185328494164, 4812.446568644581, 4827.51724827518, 4842.12841688496, 4735.289706544011, 4781.139394908915, 4792.808287668489, 4797.664163508556, 4844.903101937976, 5153.716545589991, 5239.502247286502, 5251.501107394792, 5266.394364648077, 5315.654482458628, 5791.449812267828, 5815.854603634901, 5884.941150588482, 5902.527797776168, 5909.23179986599, 5880.323762767293, 5892.351841297454, 5896.262967129109, 5897.233359663259, 5899.233099697012, 5447.291852059207, 5450.645708028966, 5455.781768729285, 5460.208269800856, 5461.672299662033, 5882.970585147047, 5974.671393073423, 5998.310194327621, 6052.697365131726, 6083.969580152159, 5623.297087864017, 5639.548836093103, 5667.546596272288, 5688.431156884279, 5707.600467967285, 5765.481106700333, 5765.942340576625, 5796.043652797325, 5811.79658711943, 5822.737976791054, 5780.71096445176, 5784.334801497882, 5796.5072968797285, 5797.449242321973, 5797.710114494258, 5780.0, 5780.237027706506, 5783.479486846204, 5790.594658373958, 5798.391168927286, 4495.100979804052, 4506.81972721094, 4539.296409056601, 4540.931886021713, 4574.039451715177, 3961.187956468917, 3975.2248311578965, 3989.2819292527624, 4016.718829681894, 4024.8188831502653, 4877.951220487821, 5026.371703537058, 5027.3464449621315, 5030.874228144326, 5040.59675225981, 5805.941940580625, 5809.622374545641, 5884.47039766423, 5888.705564721747, 5889.440503152194, 5013.849584512471, 5023.9700861323345, 5032.3961124665275, 5051.974740126276, 5077.339945807095, 5210.348706411699, 5228.555572776357, 5230.137027390514, 5243.737813109329, 5288.995090932711, 5303.204519322133, 5358.866028349323, 5432.0, 5437.912417516433, 5471.9726401369335, 5840.853978650568, 5863.237779088691, 5871.972404829053, 5926.970365148147, 5943.64338139713, 5407.918881216706, 5440.047991601533, 5445.673259604437, 5460.7542660579575, 5460.808871689472, 5633.690147041788, 5665.943340566707, 5736.598438109292, 5758.3090029196765, 5778.046622307273, 5817.447342502455, 5847.678377689098, 5857.238558987305, 5872.794452194153, 5890.52875769946, 5611.466910643482, 5677.914831277617, 5679.77280908759, 5682.318121825408, 5688.146777983336, 5435.0, 5674.0, 5694.316681998187, 5697.059985102577, 5699.401562836008, 5460.890782184413, 5543.362513311021, 5557.972210138923, 5603.0, 5615.550755939434, 5687.687177205294, 5709.743061562157, 5711.742971566373, 5720.628159169641, 5725.08398656213, 5449.891002180014, 5490.615656904138, 5559.444055594408, 5604.943950560442, 5642.689652069175], "value": 5264.5433451865165, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [728.6283995162468, 745.3925051083365, 1066.4028144239226, 1089.5532831539072, 1172.4079339933332, 35425.46861797075, 36172.28707846912, 36234.63765362345, 36272.0, 36326.0, 33697.157571060736, 33869.0, 33901.321973560574, 34047.0, 34078.148046298855, 6658.633775142377, 6795.93204067958, 7160.212376638566, 7351.632418379087, 7366.410687145042, 7335.633218339089, 7392.519486233405, 7410.333070023697, 7419.443541734391, 7461.776146715607, 7379.778606641809, 7418.814529636748, 7477.065366829146, 7477.1775104738435, 7488.475806693534, 7389.150247721527, 7400.62996850158, 7449.180590135081, 7452.813679657997, 7459.030326057577, 7240.891386629205, 7270.309320614533, 7295.270472952715, 7298.927010729878, 7326.853462930711, 33680.326393471994, 33828.58742601172, 34022.48966265508, 34027.829860850536, 34200.65799342, 2968.2134234427895, 2968.465676178287, 2982.642082950038, 2987.1038688393614, 3001.0996700989617, 25823.741762582322, 25828.612570811452, 25839.483210335875, 25882.0, 25920.0, 3176.3806057818733, 3225.451673215559, 3226.1934516370907, 3232.563603913489, 3249.951250731241, 155729.2213538925, 158369.0, 158564.0, 158909.0, 159457.2027139857, 41619.79190104091, 42095.36856947148, 42840.0, 43008.56991430108, 43017.35473967893, 44638.0, 44821.327680084825, 44834.0, 44906.55093449024, 45046.0, 13592.728145437233, 13636.522721704692, 13678.658033549042, 13706.588802335946, 13740.244286564335, 10945.0, 10977.365432296192, 10985.725356866142, 10996.890031099747, 11123.221374503708, 13473.0, 13583.320833958263, 13631.659208519866, 13706.862931370759, 13832.723345533233, 5349.786008559614, 5434.429384914606, 5440.211169380497, 5508.256385388001, 5577.581681373913, 878.7100256915203, 896.7489103051156, 916.4501299220548, 923.2890674180977, 933.9299552533587, 20647.8967605161, 21388.572228555342, 21447.67828482574, 21494.57010859774, 21643.13427462884, 989.3618615992789, 994.8259054665549, 999.5052449037628, 1000.0649392817738, 1014.6702321745462, 11300.660980170607, 11362.261453005529, 11373.31760094397, 11408.771824563462, 11431.0, 246583.0, 246651.0, 248228.10631362177, 248614.0, 248922.0, 42340.3648945266, 42395.1520969585, 42449.57550424456, 42478.57521424746, 42529.57470425256, 1204.8072308430785, 1268.0996492490435, 1269.0418733856063, 1270.6505710929384, 1273.121546133165, 19645.50886227856, 19876.60246795085, 20850.165993360097, 20898.268560600307, 20921.581568368852, 30547.389052219274, 30604.234894126934, 30605.693943061175, 30694.23264418318, 30939.535906961864, 211144.0, 212148.0, 212377.0, 212648.0, 213102.0, 29992.700072998992, 31088.68911310858, 31604.209894752814, 31710.0, 31725.0, 36509.81745091364, 36624.81687591545, 36997.445038324986, 37691.0, 37762.622373775914, 27840.303992400353, 28116.156515304574, 28156.71843281541, 29015.85492072526, 29477.26306842346, 28463.573046404734, 28502.287442814097, 28547.28631784139, 28780.856095719388, 29623.111306660834, 31132.0, 31554.684453156093, 31637.20906977344, 31668.841655791573, 31676.841615791775, 26943.595846062715, 27435.588466173424, 27437.45125097447, 27785.166445006682, 28088.0, 21039.474013149793, 22306.665400019338, 22903.0, 23081.192158274378, 23087.307380778602], "value": 15359.55624554291, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [426.5159044484509, 434.9782510874455, 439.6263176300145, 445.9777011149442, 454.3502791008858, 17207.827921720764, 18367.816321836777, 18940.71588926164, 18982.43052708421, 19089.52276193096, 17308.663330450385, 18460.53848653781, 19423.417297481064, 19738.407847764553, 19741.40775776729, 5263.3683957925, 5495.477929596702, 5512.862178445551, 5521.116621340586, 5528.032594295983, 5488.423715509874, 5520.779168833242, 5609.242752228458, 5616.157576363557, 5627.986962346776, 5528.44715528448, 5640.097584386499, 5648.039833228361, 5653.180288858113, 5653.321601407837, 5465.9726701366235, 5524.155060144029, 5586.050371436845, 5615.0454422748235, 5618.971905140468, 4978.427480839714, 4979.253112033188, 4985.800567977277, 4999.150144475448, 5000.099982003274, 22176.0, 22272.329575281918, 22285.554288914293, 22374.776252237432, 22578.887105564532, 1654.346533119411, 1685.2500637216444, 1689.7465380192946, 1693.2549678141702, 1698.5753561609597, 14486.855131448761, 14487.565373038826, 14999.925000374928, 15067.4726384576, 15256.084634921941, 2025.706272590481, 2064.6593312103487, 2133.1787261904124, 2152.0961196297594, 2152.666336717811, 91318.0, 91970.0, 92897.53551232268, 94169.5291523538, 95056.9999999993, 11149.554017839358, 11177.83233251502, 11206.495707693173, 11328.546858125748, 11528.481218345194, 15965.840341596668, 15982.0, 15986.120763357894, 16043.598910027342, 16055.438059667855, 7406.629668516553, 7482.1021477423055, 7590.0, 7693.269139431745, 7734.729284475129, 6734.730610775514, 6783.62690052042, 6801.063033168327, 7020.894686579705, 7042.154941406961, 7060.894086588705, 7247.130344358605, 7248.6738096785775, 7260.927390726025, 7287.854242915112, 2062.329742833585, 2075.63676356637, 2119.3959721479305, 2135.263334149716, 2245.2029529517113, 841.8947631546057, 877.8814859993819, 888.1784349476708, 889.4352086425166, 909.9044600317004, 16372.426965056165, 16870.746938795928, 17237.31050757981, 17609.11954402275, 17755.0, 875.7197696737111, 887.1306120002433, 895.4492986813193, 919.9126083022102, 920.5581320965974, 9065.909340906639, 9617.51912404377, 9644.282869907094, 9662.516874156265, 9677.758056048655, 483371.0, 487376.0, 487807.0, 497947.0, 498422.0, 86398.56800716082, 87011.56494217488, 87981.0, 89564.0, 90767.0, 1073.0664322039875, 1079.519613771864, 1104.536094840169, 1110.2228440091806, 1115.2249186815247, 14835.406583736529, 17428.651426971643, 19302.7104593434, 19306.131224095232, 19333.0, 43192.0, 44211.77894110509, 44766.3285050731, 45275.0, 45618.0, 52682.73658631682, 53206.0, 53555.698866675724, 55113.44886551083, 55185.724071380995, 8346.12365701617, 8466.703665371682, 8476.27951624119, 8603.311735061305, 8856.3800533962, 13239.470421183045, 13307.0, 13356.465741370237, 13473.393697283842, 13491.25798081115, 10518.684439466828, 10556.577736890438, 10581.735456613646, 10695.518701658288, 10922.945385273022, 10896.673099807018, 10981.725456863642, 11017.779644407226, 11048.558057677603, 11182.66452006441, 9848.950755246464, 9897.208223341971, 9917.206623469961, 10276.948615256875, 10363.792724145625, 8342.196855072816, 8524.445911015764, 8560.700375486827, 8591.269742071994, 8713.390062695551, 10295.588176472857, 10320.43237621908, 10341.689749307532, 10349.689509314732, 10724.0], "value": 9129.402561091805, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1248.3259040118337, 1371.6707990082384, 1375.7523645743763, 1378.359063035689, 1387.8403983541893, 9997.15024222941, 10532.947335263312, 10553.366797992116, 10566.366018038903, 10826.404547749871, 10574.947125264382, 10751.62369317074, 10790.73023174419, 10815.567377304898, 10821.080208182295, 2334.894929728162, 2366.148186652804, 2367.562001029806, 2368.751281115484, 2372.525494901018, 2201.7908298711595, 2302.6776251324827, 2309.9538009239805, 2311.295055008222, 2316.339843144704, 2212.413710366754, 2214.0922221889027, 2225.6661500774853, 2252.076648574085, 2293.483966107629, 2040.8571400002006, 2167.642339014061, 2187.6499760038396, 2203.294945617403, 2205.2391924786, 2170.5441857210003, 2172.2180015194517, 2180.6728990651527, 2183.148572056899, 2270.2735124760084, 10443.112335451497, 10506.264561480699, 10534.104601108915, 10566.735831604272, 10568.313059651175, 5722.828315150552, 5897.64614123154, 5934.258217722785, 5949.315828679714, 5956.195913551702, 3269.362474317509, 3382.8646854125805, 3442.7590068695204, 3486.3201675673254, 3489.7906125632544, 1115.2304909612424, 1188.7028242939266, 1191.791436498618, 1200.993995030028, 1209.9576514822027, 15293.623573878293, 15414.537563873102, 15465.922670386575, 15514.146721930289, 15523.06861588297, 4811.807527698923, 4950.297616080236, 5176.0, 5228.869278268074, 5260.9736951315, 11383.487743051583, 11403.657890263305, 11438.428078596036, 11451.312921224753, 11454.083673306282, 5683.715814209273, 5751.9424805751405, 5766.365699773021, 5798.8550286242335, 5818.738156782955, 5181.766820493087, 5186.170212765939, 5225.895482090413, 5226.085435048852, 5309.309789727311, 3989.9002524936527, 4078.816453259551, 4104.138130992465, 4176.937345939813, 4196.727212731163, 1195.5576436718295, 1198.1972078707288, 1209.7096696792707, 1222.834917286155, 1228.4778968938165, 694.8888177891513, 698.2703075286338, 715.2775696546421, 725.1805459830358, 739.7299985505252, 5261.894762104736, 5270.973645131749, 5368.275282836845, 6271.529635277372, 6346.9682651586445, 834.0, 837.5686521441462, 839.1943734015291, 849.7535714642808, 884.5090974509209, 3683.189698266377, 3712.3317802795755, 3717.7211709121384, 3784.243151369737, 3795.3320295049334, 13333.866661333263, 13832.93083534596, 13870.722585548232, 13896.722065558632, 13927.442902283998, 13629.727405451835, 13639.590812275648, 13679.042467027411, 13681.589552313446, 13701.725965480635, 9740.75648108803, 9787.36382135159, 9795.9020409795, 9917.454540000224, 9949.452780097165, 5755.0, 5801.6519008859605, 5878.676672783038, 6083.66539840313, 6085.6348619083, 12148.21036632616, 12351.876481235433, 12404.379781011094, 12405.131640785059, 12470.438830252479, 12536.185147965352, 12552.623421297376, 12650.493980240688, 12710.428030738454, 12729.80905286403, 7695.23047695226, 7756.108047574376, 7796.805079872822, 7843.058832939855, 7871.606419679108, 9340.486273254764, 9448.196903263299, 9454.810903782023, 9455.621775129193, 9456.0, 8002.919970800217, 8116.878246826184, 8119.5534245617055, 8155.469894456842, 8281.21328473794, 8142.226488483585, 8190.344772418312, 8228.21831925966, 8270.214329638675, 8459.0, 7264.636768161465, 7292.890606641011, 7385.889211661937, 7420.40636749048, 7429.405647548075, 4152.979235103805, 5012.799488020439, 5042.672226305279, 5102.897942041212, 5155.742212889266, 5025.680840898308, 5052.5705315048635, 5085.4406015337545, 5089.0, 5104.69371837691], "value": 4876.344898454071, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [393.47471126046725, 394.40641834039747, 405.541737836245, 407.912298855746, 409.59100693613976, 5373.247745315659, 5498.3127109111365, 5534.584906132036, 5545.528630066439, 5568.1091025435935, 5308.362996440433, 5416.07926652469, 5418.756155972981, 5419.430959749228, 5425.9728701356435, 4041.9595804042024, 4145.7719825409595, 4148.294789885712, 4153.979230103845, 4159.480064991876, 4147.668186545069, 4152.68854835887, 4153.9199808049825, 4154.356074808409, 4163.208990291835, 4116.300228961069, 4119.608637179464, 4137.565555616647, 4141.275276826558, 4152.107296931159, 3929.941050884239, 4085.407615895708, 4142.502899652046, 4143.585641435862, 4144.772037537934, 3607.7474576779637, 3613.241219343941, 3614.6023937366867, 3617.7105831533413, 3624.855005799765, 5160.406553246387, 5220.843374698765, 5228.895422091575, 5244.318238628992, 5256.58197229275, 4579.587837094644, 4866.712645056818, 4880.341153944243, 4884.731339776311, 4904.8773780655765, 5678.375378708339, 5709.857253568694, 5723.284589426322, 5726.885462290773, 5750.712464376807, 3980.4626375439234, 3981.402789581586, 3983.5817239190046, 3987.182627561343, 3990.5610382857863, 5583.469570390806, 6001.849953751192, 6022.548308876808, 6094.603850749687, 6117.776444711031, 4131.318332475168, 4170.374443833449, 4172.395002724588, 4183.91632167355, 4184.790760462026, 4236.872893813191, 4241.554636763095, 4247.685011668648, 4251.341042138473, 4269.5090064642345, 4770.284457331428, 4813.518648135158, 4874.074740477491, 4875.7074575524875, 4903.877403064952, 5777.768889244383, 5777.855553611109, 5793.536517078624, 5801.419858014165, 5810.941890581124, 1447.9710405791825, 1465.377214683755, 1469.0671423645847, 1471.1687896338535, 1474.4397129091092, 953.68051702679, 985.7831277119022, 988.8368419210893, 990.3612170150212, 1011.5181259454934, 5041.697498150123, 5060.645754797202, 5065.721385323769, 5069.8732531687, 5083.288339632454, 5992.790252341147, 6015.105241848803, 6017.277926648742, 6032.819015429544, 6033.159886234653, 4852.51474852519, 5018.924716129261, 5021.72380519075, 5060.316857224301, 5080.847574572768, 3150.7239567975007, 3161.9051428456723, 3166.60417447819, 3167.9683203168133, 3175.7935734177204, 5542.2795036644975, 5564.443555644403, 5576.7211639417865, 5580.91628625571, 5582.469665381782, 5863.208466857005, 5869.356580157562, 6001.969990150022, 6013.338532761392, 6158.969205153946, 5476.315460567429, 5557.527610153183, 5558.166275058774, 5586.916196256978, 5611.579131565068, 5972.343042265435, 5989.580729348903, 6009.278886533469, 6009.759609615567, 6015.819525414245, 5726.398728133486, 5876.1773351731645, 5923.0, 5952.821415357546, 5954.46409823118, 5571.415001424954, 5598.916016259841, 5601.41185175567, 5610.4670056344585, 5612.0, 4061.4923134608175, 4165.083681590046, 4184.330507118846, 4200.075983283673, 4212.705110642348, 5984.760609575568, 6000.969995149996, 6017.849553761016, 6035.969820150871, 6045.304789949212, 5782.277215348082, 5785.82642520725, 5797.768089276382, 5798.0, 5824.592278540462, 5542.612017158922, 5737.655740655574, 5765.538756899354, 5784.768609255582, 5802.65184088956, 5653.773849045992, 5667.2349232854685, 5691.3170419549915, 5704.857378565569, 5713.8285851424525, 5751.223584815996, 5855.795047173328, 5864.012471519408, 5865.120231965239, 5872.823815285548, 5675.77296908119, 5711.228984087095, 5714.4856612996755, 5727.5417966561745, 5733.283339582552], "value": 4336.138255963994, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [731.4879584290994, 735.724103461202, 758.4728613613537, 764.5221736414741, 769.5998080997881, 13324.333783310844, 13674.111182773113, 13839.238841863693, 14372.640683982905, 14387.42450301988, 12974.61076167714, 13051.086423950328, 13314.533991310305, 13340.666483337896, 13424.9931255156, 828.7099515169702, 855.0338117926734, 855.7603870916122, 855.8331125430543, 858.3519442820661, 878.9736307910773, 910.8497097978826, 914.7621618379236, 920.7099763574453, 921.4195057114009, 961.0437614573509, 968.4528241543505, 969.7866469376726, 972.2756546372962, 974.9415035097882, 953.1707414549317, 959.2374062620199, 964.430985718426, 966.6181858166055, 969.6170012844887, 704.8061783009662, 711.779348401997, 715.8783006888841, 716.029779648579, 718.56526801285, 13704.0, 14104.506342278073, 15028.849711502855, 15041.871859610463, 15106.622334441618, 13961.581152565337, 14792.55622331321, 14823.407063717439, 14860.851391486054, 14888.181150036744, 11974.940125299405, 12260.938695306466, 12261.632151035483, 12345.321007344592, 12447.0, 2863.599096126544, 2892.3781387001895, 2907.825530468179, 2910.767138628905, 2919.7372236498604, 67325.0, 68089.31910680879, 68855.65572172106, 68886.0, 70252.29747702509, 10763.946180269206, 10896.18278629106, 11044.723881903017, 11125.72185695348, 11487.770244595062, 22180.0, 22280.888595556917, 22288.219912302993, 22614.886925565268, 22750.886245568665, 6206.751729930752, 6394.360563943568, 6399.232092148972, 6499.155109835691, 6511.902321465182, 3353.2119951811305, 3389.5424117743787, 3427.5715535558056, 3448.77582957107, 3460.3598334308235, 3575.4279315309427, 3660.926781464409, 3665.2119794244363, 3681.650243226889, 3730.9067273318383, 725.9201487836334, 731.5171986488892, 746.2574738135589, 749.2020997637608, 749.5427789048676, 610.7251736718495, 612.2713970375239, 629.754395785644, 630.2877748144659, 639.6961443314389, 8225.71210007647, 8823.955880220557, 9084.772880678036, 9179.219766319804, 9244.306676999251, 594.7918228620035, 609.9756009759649, 612.3631423319787, 622.0731110645106, 625.1872565664618, 4013.8595149169637, 4028.436018957348, 4112.958870411318, 4151.605597468236, 4210.45264115663, 61191.6940415304, 61833.69083154645, 61947.0, 63930.0, 66905.0, 52917.0, 53102.0, 53329.733351332994, 54041.729791350794, 55803.441965580634, 48472.5152748468, 49123.0, 49145.23933298682, 49864.50135498599, 51065.234021489705, 8459.83080338402, 8845.24815390699, 8928.15182557656, 8935.151160639729, 8954.417962832395, 25785.613215802154, 26140.8692956534, 26897.596536052366, 26979.730202697723, 27087.0, 32123.196920077185, 32135.51796723098, 32227.838860806485, 32342.514862277556, 33240.33519329551, 11320.433978301216, 11366.798139108201, 11633.360165190996, 11813.527458901548, 12064.698382540506, 12985.415656295301, 13370.390442050222, 13379.063465557318, 13408.530701425403, 13483.393247303698, 11903.166778325434, 11967.700807479883, 11970.22193557416, 12078.0, 12384.56654017105, 11564.421778910853, 11656.0, 11814.881851181379, 11909.0, 11950.223235489666, 12074.45664945062, 12081.637550873487, 12239.87760122423, 12249.387530623611, 12329.445174967328, 8298.917010829815, 8345.082040975609, 8411.70559030431, 8784.868226976729, 8932.330075244512, 8996.325275604488, 9661.46861922601, 10043.196544276587, 10239.436830974368, 10240.846387304047], "value": 6535.618218822659, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1559.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 110.0, 111.0, 111.0, 110.0, 112.0, 113.0, 110.0, 110.0], "value": 110.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 124.0, 123.0, 185.0, 130.0, 122.0, 126.0, 123.0, 155.0, 123.0], "value": 136.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 166.0, 170.0, 166.0, 175.0, 167.0, 164.0, 166.0, 165.0], "value": 167.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 105.0, 79.0, 77.0, 77.0, 75.0, 94.0, 78.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 103.0, 84.0, 85.0, 84.0, 104.0, 84.0, 89.0, 105.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 115.0, 114.0, 114.0, 115.0, 115.0, 115.0, 118.0, 124.0], "value": 115.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 151.0, 152.0, 152.0, 151.0, 151.0, 152.0, 156.0, 151.0], "value": 151.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 96.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 56.0, 53.0, 55.0, 55.0, 54.0, 55.0, 55.0, 54.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 58.0, 56.0, 56.0, 55.0, 56.0, 58.0, 55.0, 55.0], "value": 56.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 81.0, 83.0, 87.0, 82.0, 83.0, 82.0, 83.0, 82.0, 81.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 142.0, 143.0, 151.0, 136.0, 150.0, 134.0, 138.0, 185.0, 144.0], "value": 146.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 201.0, 202.0, 191.0, 197.0, 209.0, 199.0, 212.0, 201.0, 190.0], "value": 199.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 73.0, 76.0, 73.0, 75.0, 71.0, 72.0, 71.0, 73.0], "value": 72.5, "unit": "score"}]}]} 09:15:06 INFO - Return code: 0 09:15:07 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:15:07 ERROR - # TBPL SUCCESS # 09:15:07 INFO - Running post-action listener: _resource_record_post_action 09:15:07 INFO - [mozharness: 2017-04-05 16:15:07.027682Z] Finished run-tests step (success) 09:15:07 INFO - Running post-run listener: _resource_record_post_run 09:15:07 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 8192; Write bytes: 361541632; Read time: 24; Write time: 306212 09:15:07 INFO - TinderboxPrint: CPU usage
13.3% 09:15:07 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 09:15:07 INFO - TinderboxPrint: I/O write bytes / time
361,541,632 / 306,212 09:15:07 INFO - TinderboxPrint: CPU idle
8,320.4 (86.7%) 09:15:07 INFO - TinderboxPrint: CPU user
1,220.3 (12.7%) 09:15:07 INFO - TinderboxPrint: Swap in / out
0 / 0 09:15:07 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 102727680; Read time: 0; Write time: 105864 09:15:07 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 258813952; Read time: 8; Write time: 200348 09:15:07 INFO - Running post-run listener: _upload_blobber_files 09:15:07 INFO - Blob upload gear active. 09:15:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:15:07 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 09:15:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:15:08 INFO - (blobuploader) - INFO - Open directory for files ... 09:15:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:15:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:15:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:15:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:15:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:15:08 INFO - (blobuploader) - INFO - Done attempting. 09:15:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:15:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:15:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:15:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:15:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:15:09 INFO - (blobuploader) - INFO - Done attempting. 09:15:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:15:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:15:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:15:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:15:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:15:10 INFO - (blobuploader) - INFO - Done attempting. 09:15:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:15:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:15:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:15:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:15:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:15:14 INFO - (blobuploader) - INFO - Done attempting. 09:15:14 INFO - (blobuploader) - INFO - Iteration through files over. 09:15:14 INFO - Return code: 0 09:15:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:15:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:15:14 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ebc638deca0fa1c74d02c422a9028beecb4cea12cc24fde5dbb3252e83b677e7ac610f9f1f4ef8b71ca7f29dd4d6eca25d0d9745211b0ef344850c655f9a14c4", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73ff7b8dd15e98ce7b40ec12990446ad11dd378c699c8e9513f7c6b476a519e44010774028b84139c71696f4cbf414d9be3c0ea1c00f2874afbd79236983562a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3662d8ad1325518519ed75492c993f055a6503328b8e3d914ea48004abd54f05944edf1b1d1b41e748cabafe97ac7965b44b5345a9d5acc009756fb98d0f304", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/424af3506141f40eeb74d2e192114c3264657c857a906d9fdbea9afb90a0f5ebeab68dea4bc83b9f02163d11cf8c835dca92586a3615b678a89c52cbe0076c85"} 09:15:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:15:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:15:14 INFO - Contents: 09:15:14 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ebc638deca0fa1c74d02c422a9028beecb4cea12cc24fde5dbb3252e83b677e7ac610f9f1f4ef8b71ca7f29dd4d6eca25d0d9745211b0ef344850c655f9a14c4", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73ff7b8dd15e98ce7b40ec12990446ad11dd378c699c8e9513f7c6b476a519e44010774028b84139c71696f4cbf414d9be3c0ea1c00f2874afbd79236983562a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3662d8ad1325518519ed75492c993f055a6503328b8e3d914ea48004abd54f05944edf1b1d1b41e748cabafe97ac7965b44b5345a9d5acc009756fb98d0f304", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/424af3506141f40eeb74d2e192114c3264657c857a906d9fdbea9afb90a0f5ebeab68dea4bc83b9f02163d11cf8c835dca92586a3615b678a89c52cbe0076c85"} 09:15:14 INFO - Running post-run listener: copy_logs_to_upload_dir 09:15:14 INFO - Copying logs to upload dir... 09:15:14 INFO - mkdir: /builds/slave/test/build/upload/logs 09:15:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.847207 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-04-05 09:15:14.120838) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 09:15:14.124149) ========= 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=920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ebc638deca0fa1c74d02c422a9028beecb4cea12cc24fde5dbb3252e83b677e7ac610f9f1f4ef8b71ca7f29dd4d6eca25d0d9745211b0ef344850c655f9a14c4", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73ff7b8dd15e98ce7b40ec12990446ad11dd378c699c8e9513f7c6b476a519e44010774028b84139c71696f4cbf414d9be3c0ea1c00f2874afbd79236983562a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3662d8ad1325518519ed75492c993f055a6503328b8e3d914ea48004abd54f05944edf1b1d1b41e748cabafe97ac7965b44b5345a9d5acc009756fb98d0f304", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/424af3506141f40eeb74d2e192114c3264657c857a906d9fdbea9afb90a0f5ebeab68dea4bc83b9f02163d11cf8c835dca92586a3615b678a89c52cbe0076c85"} build_url:https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011325 build_url: 'https://queue.taskcluster.net/v1/task/Cf8BHR9NTTm3MbTeH25gsQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ebc638deca0fa1c74d02c422a9028beecb4cea12cc24fde5dbb3252e83b677e7ac610f9f1f4ef8b71ca7f29dd4d6eca25d0d9745211b0ef344850c655f9a14c4", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/73ff7b8dd15e98ce7b40ec12990446ad11dd378c699c8e9513f7c6b476a519e44010774028b84139c71696f4cbf414d9be3c0ea1c00f2874afbd79236983562a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f3662d8ad1325518519ed75492c993f055a6503328b8e3d914ea48004abd54f05944edf1b1d1b41e748cabafe97ac7965b44b5345a9d5acc009756fb98d0f304", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/424af3506141f40eeb74d2e192114c3264657c857a906d9fdbea9afb90a0f5ebeab68dea4bc83b9f02163d11cf8c835dca92586a3615b678a89c52cbe0076c85"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 09:15:14.152545) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 09:15:14.153108) ========= 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=920470bf432669ad7e3a5387000001ca-1491407650.691329-87901925 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004439 ========= master_lag: 0.13 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 09:15:14.286513) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 09:15:14.286850) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 09:15:14.287126) ========= ========= Total master_lag: 0.21 =========