builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs slave: talos-linux64-ix-029 starttime: 1491539991.71 results: success (0) revision: 10ea10d9993c9701e5525928257a589dea2c05d8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-06 21:39:51.711175) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-06 21:39:51.711659) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-06 21:39:51.711958) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-06 21:39:51.726710) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 21:39:51.727017) ========= 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=ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-04-06 21:39:51-- 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% 225M=0s 2017-04-06 21:39:52 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.156200 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 21:39:51.897223) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 21:39:51.897536) ========= 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=ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019779 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 21:39:51.946736) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-06 21:39:51.947072) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 10ea10d9993c9701e5525928257a589dea2c05d8 --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 10ea10d9993c9701e5525928257a589dea2c05d8 --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=ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-04-06 21:39:52,197 truncating revision to first 12 chars 2017-04-06 21:39:52,197 Setting DEBUG logging. 2017-04-06 21:39:52,197 attempt 1/10 2017-04-06 21:39:52,197 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/10ea10d9993c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-06 21:39:53,138 unpacking tar archive at: mozilla-central-10ea10d9993c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.236808 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-06 21:39:53.198616) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-06 21:39:53.198957) ========= script_repo_revision: 10ea10d9993c9701e5525928257a589dea2c05d8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-06 21:39:53.199322) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-06 21:39:53.199590) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-06 21:39:53.210333) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-04-06 21:39:53.210685) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:39:53 INFO - MultiFileLogger online at 20170406 21:39:53 in /builds/slave/test 21:39:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:39:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:39:53 INFO - {'append_to_log': False, 21:39:53 INFO - 'base_work_dir': '/builds/slave/test', 21:39:53 INFO - 'blob_upload_branch': 'Firefox', 21:39:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:39:53 INFO - 'branch': 'Firefox', 21:39:53 INFO - 'buildbot_json_path': 'buildprops.json', 21:39:53 INFO - 'config_files': ('talos/linux_config.py',), 21:39:53 INFO - 'default_actions': ('clobber', 21:39:53 INFO - 'read-buildbot-config', 21:39:53 INFO - 'download-and-extract', 21:39:53 INFO - 'populate-webroot', 21:39:53 INFO - 'create-virtualenv', 21:39:53 INFO - 'install', 21:39:53 INFO - 'run-tests'), 21:39:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:39:53 INFO - 'download_minidump_stackwalk': True, 21:39:53 INFO - 'download_symbols': 'ondemand', 21:39:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:39:53 INFO - 'tooltool.py': '/tools/tooltool.py', 21:39:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:39:53 INFO - '/tools/misc-python/virtualenv.py')}, 21:39:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:39:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:39:53 INFO - 'gecko_profile': False, 21:39:53 INFO - 'gecko_profile_interval': 0, 21:39:53 INFO - 'installer_path': 'installer.exe', 21:39:53 INFO - 'log_level': 'info', 21:39:53 INFO - 'log_name': 'talos', 21:39:53 INFO - 'log_to_console': True, 21:39:53 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:39:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:39:53 INFO - 'opt_config_files': (), 21:39:53 INFO - 'pip_index': False, 21:39:53 INFO - 'suite': 'dromaeojs', 21:39:53 INFO - 'system_bits': '32', 21:39:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:39:53 INFO - 'title': 'talos-linux64-ix-029', 21:39:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:39:53 INFO - 'use_talos_json': True, 21:39:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:39:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:39:53 INFO - 'work_dir': 'build'} 21:39:53 INFO - [mozharness: 2017-04-07 04:39:53.557962Z] Running clobber step. 21:39:53 INFO - Running pre-action listener: _resource_record_pre_action 21:39:53 INFO - Running main action method: clobber 21:39:53 INFO - rmtree: /builds/slave/test/build 21:39:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:39:54 INFO - Running post-action listener: _resource_record_post_action 21:39:54 INFO - [mozharness: 2017-04-07 04:39:54.750829Z] Finished clobber step (success) 21:39:54 INFO - [mozharness: 2017-04-07 04:39:54.750931Z] Running read-buildbot-config step. 21:39:54 INFO - Running pre-action listener: _resource_record_pre_action 21:39:54 INFO - Running main action method: read_buildbot_config 21:39:54 INFO - Using buildbot properties: 21:39:54 INFO - { 21:39:54 INFO - "project": "", 21:39:54 INFO - "product": "firefox", 21:39:54 INFO - "who": "philringnalda@gmail.com", 21:39:54 INFO - "installer_path": "public/build/target.tar.bz2", 21:39:54 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs", 21:39:54 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 21:39:54 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs", 21:39:54 INFO - "stage_platform": "linux64-stylo", 21:39:54 INFO - "basedir": "/builds/slave/test", 21:39:54 INFO - "buildnumber": 15, 21:39:54 INFO - "platform": "ubuntu64_hw_stylo", 21:39:54 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:39:54 INFO - "slavebuilddir": "test", 21:39:54 INFO - "taskId": "ejDtvsk1TzWmF-a4gKTx3w", 21:39:54 INFO - "branch": "mozilla-central", 21:39:54 INFO - "script_repo_revision": "production", 21:39:54 INFO - "revision": "10ea10d9993c9701e5525928257a589dea2c05d8", 21:39:54 INFO - "slavename": "talos-linux64-ix-029", 21:39:54 INFO - "repo_path": "mozilla-central" 21:39:54 INFO - } 21:39:54 INFO - Finding installer, test and symbols from parent task. 21:39:54 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ejDtvsk1TzWmF-a4gKTx3w'}, attempt #1 21:39:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ejDtvsk1TzWmF-a4gKTx3w'}, attempt #1 21:39:55 INFO - Task dependencies: ewNiahj9SiyhbBLYmN-paQ 21:39:55 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ'}, attempt #1 21:39:56 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ/artifacts/public/build/target.tar.bz2 21:39:56 INFO - Set test_url: https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ/artifacts/public/build/test_packages.json 21:39:56 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ/artifacts/public/build/target.crashreporter-symbols.zip 21:39:56 INFO - Running post-action listener: _resource_record_post_action 21:39:56 INFO - [mozharness: 2017-04-07 04:39:56.195008Z] Finished read-buildbot-config step (success) 21:39:56 INFO - [mozharness: 2017-04-07 04:39:56.195226Z] Running download-and-extract step. 21:39:56 INFO - Running pre-action listener: _resource_record_pre_action 21:39:56 INFO - Running main action method: download_and_extract 21:39:56 INFO - mkdir: /builds/slave/test/build/tests 21:39:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:39:56 INFO - trying https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ/artifacts/public/build/target.test_packages.json 21:39:56 INFO - Downloading https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:39:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:39:56 INFO - Downloaded 986 bytes. 21:39:56 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:39:56 INFO - Using the following test package requirements: 21:39:56 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 21:39:56 INFO - u'common': [u'target.common.tests.zip'], 21:39:56 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:39:56 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:39:56 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:39:56 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:39:56 INFO - u'mozbase': [u'target.common.tests.zip'], 21:39:56 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:39:56 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:39:56 INFO - u'web-platform': [u'target.common.tests.zip', 21:39:56 INFO - u'target.web-platform.tests.zip'], 21:39:56 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:39:56 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 21:39:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ/artifacts/public/build/target.common.tests.zip 21:39:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:39:56 INFO - Fetch https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ/artifacts/public/build/target.common.tests.zip into memory 21:39:57 INFO - Expected file size: 58243759 21:39:57 INFO - Obtained file size: 58243759 21:40:07 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 21:40:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ/artifacts/public/build/target.common.tests.zip 21:40:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:40:07 INFO - Fetch https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ/artifacts/public/build/target.common.tests.zip into memory 21:40:08 INFO - Expected file size: 58243759 21:40:08 INFO - Obtained file size: 58243759 21:40:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ/artifacts/public/build/target.talos.tests.zip 21:40:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:40:19 INFO - Fetch https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ/artifacts/public/build/target.talos.tests.zip into memory 21:40:20 INFO - Expected file size: 14404138 21:40:20 INFO - Obtained file size: 14404138 21:40:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:20 INFO - trying https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ/artifacts/public/build/target.tar.bz2 21:40:20 INFO - Downloading https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:40:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:40:21 INFO - Downloaded 59110939 bytes. 21:40:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ/artifacts/public/build/target.tar.bz2 21:40:21 INFO - mkdir: /builds/slave/test/properties 21:40:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:40:21 INFO - Writing to file /builds/slave/test/properties/build_url 21:40:21 INFO - Contents: 21:40:21 INFO - build_url:https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ/artifacts/public/build/target.tar.bz2 21:40:21 INFO - Running post-action listener: _resource_record_post_action 21:40:21 INFO - Running post-action listener: set_extra_try_arguments 21:40:21 INFO - [mozharness: 2017-04-07 04:40:21.827429Z] Finished download-and-extract step (success) 21:40:21 INFO - [mozharness: 2017-04-07 04:40:21.827526Z] Running populate-webroot step. 21:40:21 INFO - Running pre-action listener: _resource_record_pre_action 21:40:21 INFO - Running main action method: populate_webroot 21:40:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:40:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:40:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:40:21 INFO - '--tppagecycles', 21:40:21 INFO - '7'], 21:40:21 INFO - 'tests': ['tsvgm']}}, 21:40:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:40:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:40:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:40:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:40:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:40:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:40:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:40:21 INFO - 'talos_options': ['--disable-e10s'], 21:40:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:40:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:40:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:40:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:40:21 INFO - 'talos_options': ['--disable-e10s'], 21:40:21 INFO - 'tests': ['damp', 'tps']}, 21:40:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:40:21 INFO - 'tests': ['damp', 'tps']}, 21:40:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:40:21 INFO - 'tests': ['dromaeo_dom']}, 21:40:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:40:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:40:21 INFO - 'tests': ['basic_compositor_video']}, 21:40:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:40:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:40:21 INFO - 'tests': ['a11yr', 21:40:21 INFO - 'ts_paint', 21:40:21 INFO - 'tpaint', 21:40:21 INFO - 'sessionrestore', 21:40:21 INFO - 'sessionrestore_no_auto_restore', 21:40:21 INFO - 'tabpaint']}, 21:40:21 INFO - 'other-e10s': {'tests': ['a11yr', 21:40:21 INFO - 'ts_paint', 21:40:21 INFO - 'tpaint', 21:40:21 INFO - 'sessionrestore', 21:40:21 INFO - 'sessionrestore_no_auto_restore', 21:40:21 INFO - 'tabpaint']}, 21:40:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:40:21 INFO - 'ts_paint', 21:40:21 INFO - 'tpaint', 21:40:21 INFO - 'sessionrestore', 21:40:21 INFO - 'sessionrestore_no_auto_restore', 21:40:21 INFO - 'tabpaint']}, 21:40:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:40:21 INFO - 'ts_paint', 21:40:21 INFO - 'tpaint', 21:40:21 INFO - 'sessionrestore', 21:40:21 INFO - 'sessionrestore_no_auto_restore', 21:40:21 INFO - 'tabpaint']}, 21:40:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:40:21 INFO - 'tests': ['a11yr', 21:40:21 INFO - 'ts_paint', 21:40:21 INFO - 'tpaint', 21:40:21 INFO - 'sessionrestore', 21:40:21 INFO - 'sessionrestore_no_auto_restore', 21:40:21 INFO - 'tabpaint']}, 21:40:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:40:21 INFO - 'tests': ['a11yr', 21:40:21 INFO - 'ts_paint', 21:40:21 INFO - 'tpaint', 21:40:21 INFO - 'sessionrestore', 21:40:21 INFO - 'sessionrestore_no_auto_restore', 21:40:21 INFO - 'tabpaint']}, 21:40:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:40:21 INFO - 'tests': ['tsvgx', 21:40:21 INFO - 'tsvgr_opacity', 21:40:21 INFO - 'tart', 21:40:21 INFO - 'tscrollx', 21:40:21 INFO - 'cart', 21:40:21 INFO - 'tsvg_static']}, 21:40:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:40:21 INFO - 'tsvgr_opacity', 21:40:21 INFO - 'tart', 21:40:21 INFO - 'tscrollx', 21:40:21 INFO - 'cart', 21:40:21 INFO - 'tsvg_static']}, 21:40:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:40:21 INFO - 'talos_options': ['--disable-e10s'], 21:40:21 INFO - 'tests': ['tp5o']}, 21:40:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:40:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:40:21 INFO - 'talos_options': ['--disable-e10s', 21:40:21 INFO - '--xperf_path', 21:40:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:40:21 INFO - 'tests': ['tp5n']}, 21:40:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:40:21 INFO - 'talos_options': ['--xperf_path', 21:40:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:40:21 INFO - 'tests': ['tp5n']}}, 21:40:21 INFO - 'talos.zip': {'path': '', 21:40:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:40:21 INFO - Running post-action listener: _resource_record_post_action 21:40:21 INFO - [mozharness: 2017-04-07 04:40:21.840725Z] Finished populate-webroot step (success) 21:40:21 INFO - [mozharness: 2017-04-07 04:40:21.840814Z] Running create-virtualenv step. 21:40:21 INFO - Running pre-action listener: _resource_record_pre_action 21:40:21 INFO - Running main action method: create_virtualenv 21:40:21 INFO - Creating virtualenv /builds/slave/test/build/venv 21:40:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 21:40:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:40:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:40:21 INFO - Using real prefix '/usr' 21:40:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:40:22 INFO - Installing distribute.............................................................................................................................................................................................done. 21:40:24 INFO - Installing pip.................done. 21:40:24 INFO - Return code: 0 21:40:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:40:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:40:24 INFO - Reading from file tmpfile_stdout 21:40:24 INFO - Output received: 21:40:24 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:40:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:24 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 0x1e201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bb400>, '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 0x20bc3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bc840>, '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': 'ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:40:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:40:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:40:24 INFO - Using env: {'DISPLAY': ':0', 21:40:24 INFO - 'HOME': '/home/cltbld', 21:40:24 INFO - 'LANG': 'en_US.UTF-8', 21:40:24 INFO - 'LANGUAGE': 'en_US:en', 21:40:24 INFO - 'LOGNAME': 'cltbld', 21:40:24 INFO - 'MAIL': '/var/mail/cltbld', 21:40:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:24 INFO - 'MOZ_NO_REMOTE': '1', 21:40:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:40:24 INFO - 'NO_EM_RESTART': '1', 21:40:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:40:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:24 INFO - 'PWD': '/builds/slave/test', 21:40:24 INFO - 'SHELL': '/bin/bash', 21:40:24 INFO - 'SHLVL': '1', 21:40:24 INFO - 'TERM': 'linux', 21:40:24 INFO - 'TMOUT': '86400', 21:40:24 INFO - 'USER': 'cltbld', 21:40:24 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729', 21:40:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:24 INFO - '_': '/tools/buildbot/bin/python'} 21:40:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:24 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 21:40:24 INFO - Cleaning up... 21:40:24 INFO - Return code: 0 21:40:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:24 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 0x1e201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bb400>, '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 0x20bc3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bc840>, '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': 'ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:40:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:40:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:40:24 INFO - Using env: {'DISPLAY': ':0', 21:40:24 INFO - 'HOME': '/home/cltbld', 21:40:24 INFO - 'LANG': 'en_US.UTF-8', 21:40:24 INFO - 'LANGUAGE': 'en_US:en', 21:40:24 INFO - 'LOGNAME': 'cltbld', 21:40:24 INFO - 'MAIL': '/var/mail/cltbld', 21:40:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:24 INFO - 'MOZ_NO_REMOTE': '1', 21:40:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:40:24 INFO - 'NO_EM_RESTART': '1', 21:40:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:40:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:24 INFO - 'PWD': '/builds/slave/test', 21:40:24 INFO - 'SHELL': '/bin/bash', 21:40:24 INFO - 'SHLVL': '1', 21:40:24 INFO - 'TERM': 'linux', 21:40:24 INFO - 'TMOUT': '86400', 21:40:24 INFO - 'USER': 'cltbld', 21:40:24 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729', 21:40:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:24 INFO - '_': '/tools/buildbot/bin/python'} 21:40:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:25 INFO - Downloading/unpacking psutil>=3.1.1 21:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:40:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:40:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:40:27 INFO - Installing collected packages: psutil 21:40:27 INFO - Running setup.py install for psutil 21:40:27 INFO - building 'psutil._psutil_linux' extension 21:40:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 21:40:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 21:40:27 INFO - building 'psutil._psutil_posix' extension 21:40:27 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 21:40:27 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 21:40:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:40:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:40:27 INFO - Successfully installed psutil 21:40:27 INFO - Cleaning up... 21:40:27 INFO - Return code: 0 21:40:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bb400>, '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 0x20bc3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bc840>, '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': 'ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:40:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 21:40:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:40:27 INFO - Using env: {'DISPLAY': ':0', 21:40:27 INFO - 'HOME': '/home/cltbld', 21:40:27 INFO - 'LANG': 'en_US.UTF-8', 21:40:27 INFO - 'LANGUAGE': 'en_US:en', 21:40:27 INFO - 'LOGNAME': 'cltbld', 21:40:27 INFO - 'MAIL': '/var/mail/cltbld', 21:40:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:27 INFO - 'MOZ_NO_REMOTE': '1', 21:40:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:40:27 INFO - 'NO_EM_RESTART': '1', 21:40:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:40:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:27 INFO - 'PWD': '/builds/slave/test', 21:40:27 INFO - 'SHELL': '/bin/bash', 21:40:27 INFO - 'SHLVL': '1', 21:40:27 INFO - 'TERM': 'linux', 21:40:27 INFO - 'TMOUT': '86400', 21:40:27 INFO - 'USER': 'cltbld', 21:40:27 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729', 21:40:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:27 INFO - '_': '/tools/buildbot/bin/python'} 21:40:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:40:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:40:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:40:30 INFO - Installing collected packages: mozsystemmonitor 21:40:30 INFO - Running setup.py install for mozsystemmonitor 21:40:30 INFO - Successfully installed mozsystemmonitor 21:40:30 INFO - Cleaning up... 21:40:30 INFO - Return code: 0 21:40:30 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:40:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:30 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 0x1e201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bb400>, '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 0x20bc3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bc840>, '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': 'ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:40:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:40:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:40:30 INFO - Using env: {'DISPLAY': ':0', 21:40:30 INFO - 'HOME': '/home/cltbld', 21:40:30 INFO - 'LANG': 'en_US.UTF-8', 21:40:30 INFO - 'LANGUAGE': 'en_US:en', 21:40:30 INFO - 'LOGNAME': 'cltbld', 21:40:30 INFO - 'MAIL': '/var/mail/cltbld', 21:40:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:30 INFO - 'MOZ_NO_REMOTE': '1', 21:40:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:40:30 INFO - 'NO_EM_RESTART': '1', 21:40:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:40:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:30 INFO - 'PWD': '/builds/slave/test', 21:40:30 INFO - 'SHELL': '/bin/bash', 21:40:30 INFO - 'SHLVL': '1', 21:40:30 INFO - 'TERM': 'linux', 21:40:30 INFO - 'TMOUT': '86400', 21:40:30 INFO - 'USER': 'cltbld', 21:40:30 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729', 21:40:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:30 INFO - '_': '/tools/buildbot/bin/python'} 21:40:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:30 INFO - Downloading/unpacking jsonschema==2.5.1 21:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:40:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:32 INFO - Downloading functools32-3.2.3-2.tar.gz 21:40:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:40:32 INFO - warning: no files found matching '*.txt' 21:40:32 INFO - no previously-included directories found matching 'build' 21:40:32 INFO - no previously-included directories found matching 'dist' 21:40:32 INFO - no previously-included directories found matching '.git*' 21:40:32 INFO - Installing collected packages: jsonschema, functools32 21:40:32 INFO - Running setup.py install for functools32 21:40:32 INFO - warning: no files found matching '*.txt' 21:40:32 INFO - no previously-included directories found matching 'build' 21:40:32 INFO - no previously-included directories found matching 'dist' 21:40:32 INFO - no previously-included directories found matching '.git*' 21:40:32 INFO - Successfully installed jsonschema functools32 21:40:32 INFO - Cleaning up... 21:40:32 INFO - Return code: 0 21:40:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:40:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1e201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bb400>, '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 0x20bc3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bc840>, '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': 'ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:40:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 21:40:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:40:32 INFO - Using env: {'DISPLAY': ':0', 21:40:32 INFO - 'HOME': '/home/cltbld', 21:40:32 INFO - 'LANG': 'en_US.UTF-8', 21:40:32 INFO - 'LANGUAGE': 'en_US:en', 21:40:32 INFO - 'LOGNAME': 'cltbld', 21:40:32 INFO - 'MAIL': '/var/mail/cltbld', 21:40:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:32 INFO - 'MOZ_NO_REMOTE': '1', 21:40:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:40:32 INFO - 'NO_EM_RESTART': '1', 21:40:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:40:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:32 INFO - 'PWD': '/builds/slave/test', 21:40:32 INFO - 'SHELL': '/bin/bash', 21:40:32 INFO - 'SHLVL': '1', 21:40:32 INFO - 'TERM': 'linux', 21:40:32 INFO - 'TMOUT': '86400', 21:40:32 INFO - 'USER': 'cltbld', 21:40:32 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729', 21:40:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:32 INFO - '_': '/tools/buildbot/bin/python'} 21:40:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:40:33 INFO - Cleaning up... 21:40:33 INFO - Return code: 0 21:40:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:33 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 0x1e201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bb400>, '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 0x20bc3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bc840>, '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': 'ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:40:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 21:40:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:40:33 INFO - Using env: {'DISPLAY': ':0', 21:40:33 INFO - 'HOME': '/home/cltbld', 21:40:33 INFO - 'LANG': 'en_US.UTF-8', 21:40:33 INFO - 'LANGUAGE': 'en_US:en', 21:40:33 INFO - 'LOGNAME': 'cltbld', 21:40:33 INFO - 'MAIL': '/var/mail/cltbld', 21:40:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:33 INFO - 'MOZ_NO_REMOTE': '1', 21:40:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:40:33 INFO - 'NO_EM_RESTART': '1', 21:40:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:40:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:33 INFO - 'PWD': '/builds/slave/test', 21:40:33 INFO - 'SHELL': '/bin/bash', 21:40:33 INFO - 'SHLVL': '1', 21:40:33 INFO - 'TERM': 'linux', 21:40:33 INFO - 'TMOUT': '86400', 21:40:33 INFO - 'USER': 'cltbld', 21:40:33 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729', 21:40:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:33 INFO - '_': '/tools/buildbot/bin/python'} 21:40:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:33 INFO - Downloading/unpacking blobuploader==1.2.4 21:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:35 INFO - Downloading blobuploader-1.2.4.tar.gz 21:40:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:40:35 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:40:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:36 INFO - Downloading docopt-0.6.1.tar.gz 21:40:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:40:36 INFO - Installing collected packages: blobuploader, requests, docopt 21:40:36 INFO - Running setup.py install for blobuploader 21:40:36 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:40:36 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:40:36 INFO - Running setup.py install for requests 21:40:36 INFO - Running setup.py install for docopt 21:40:36 INFO - Successfully installed blobuploader requests docopt 21:40:36 INFO - Cleaning up... 21:40:36 INFO - Return code: 0 21:40:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:36 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 0x1e201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bb400>, '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 0x20bc3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bc840>, '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': 'ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:40:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:40:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:40:36 INFO - Using env: {'DISPLAY': ':0', 21:40:36 INFO - 'HOME': '/home/cltbld', 21:40:36 INFO - 'LANG': 'en_US.UTF-8', 21:40:36 INFO - 'LANGUAGE': 'en_US:en', 21:40:36 INFO - 'LOGNAME': 'cltbld', 21:40:36 INFO - 'MAIL': '/var/mail/cltbld', 21:40:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:36 INFO - 'MOZ_NO_REMOTE': '1', 21:40:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:40:36 INFO - 'NO_EM_RESTART': '1', 21:40:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:40:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:36 INFO - 'PWD': '/builds/slave/test', 21:40:36 INFO - 'SHELL': '/bin/bash', 21:40:36 INFO - 'SHLVL': '1', 21:40:36 INFO - 'TERM': 'linux', 21:40:36 INFO - 'TMOUT': '86400', 21:40:36 INFO - 'USER': 'cltbld', 21:40:36 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729', 21:40:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:36 INFO - '_': '/tools/buildbot/bin/python'} 21:40:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:40:36 INFO - Running setup.py (path:/tmp/pip-9_cpCF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:40:37 INFO - Running setup.py (path:/tmp/pip-nkjQ6p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:40:37 INFO - Running setup.py (path:/tmp/pip-iHm7UU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:40:37 INFO - Running setup.py (path:/tmp/pip-nX0juH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:40:37 INFO - Running setup.py (path:/tmp/pip-7Qnjgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:40:37 INFO - Running setup.py (path:/tmp/pip-M6qTnd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:40:37 INFO - Running setup.py (path:/tmp/pip-Brbzxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:40:37 INFO - Running setup.py (path:/tmp/pip-dLJNpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:40:37 INFO - Running setup.py (path:/tmp/pip-ej5W1l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:40:37 INFO - Running setup.py (path:/tmp/pip-jb9II1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:40:37 INFO - Running setup.py (path:/tmp/pip-iTl4B7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:40:37 INFO - Running setup.py (path:/tmp/pip-5I_QtB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:40:37 INFO - Running setup.py (path:/tmp/pip-RFUgR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:40:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:40:37 INFO - Running setup.py (path:/tmp/pip-CR6n5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:40:38 INFO - Running setup.py (path:/tmp/pip-n3QFEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:40:38 INFO - Running setup.py (path:/tmp/pip-aeN3CG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:40:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:40:38 INFO - Running setup.py (path:/tmp/pip-s6RbVZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:40:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:40:38 INFO - Running setup.py install for manifestparser 21:40:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:40:38 INFO - Running setup.py install for mozcrash 21:40:38 INFO - Running setup.py install for mozdebug 21:40:38 INFO - Running setup.py install for mozdevice 21:40:38 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:40:38 INFO - Running setup.py install for mozfile 21:40:38 INFO - Running setup.py install for mozhttpd 21:40:38 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:40:38 INFO - Running setup.py install for mozinfo 21:40:38 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:40:38 INFO - Running setup.py install for mozInstall 21:40:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:40:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:40:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:40:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:40:39 INFO - Running setup.py install for mozleak 21:40:39 INFO - Running setup.py install for mozlog 21:40:39 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:40:39 INFO - Running setup.py install for moznetwork 21:40:39 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:40:39 INFO - Running setup.py install for mozprocess 21:40:39 INFO - Running setup.py install for mozprofile 21:40:39 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:40:39 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:40:39 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:40:39 INFO - Running setup.py install for mozrunner 21:40:39 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:40:39 INFO - Running setup.py install for mozscreenshot 21:40:39 INFO - Running setup.py install for moztest 21:40:39 INFO - Running setup.py install for mozversion 21:40:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:40:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:40:39 INFO - Cleaning up... 21:40:40 INFO - Return code: 0 21:40:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:40 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 0x1e201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bb400>, '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 0x20bc3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bc840>, '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': 'ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:40:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:40:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:40:40 INFO - Using env: {'DISPLAY': ':0', 21:40:40 INFO - 'HOME': '/home/cltbld', 21:40:40 INFO - 'LANG': 'en_US.UTF-8', 21:40:40 INFO - 'LANGUAGE': 'en_US:en', 21:40:40 INFO - 'LOGNAME': 'cltbld', 21:40:40 INFO - 'MAIL': '/var/mail/cltbld', 21:40:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:40 INFO - 'MOZ_NO_REMOTE': '1', 21:40:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:40:40 INFO - 'NO_EM_RESTART': '1', 21:40:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:40:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:40 INFO - 'PWD': '/builds/slave/test', 21:40:40 INFO - 'SHELL': '/bin/bash', 21:40:40 INFO - 'SHLVL': '1', 21:40:40 INFO - 'TERM': 'linux', 21:40:40 INFO - 'TMOUT': '86400', 21:40:40 INFO - 'USER': 'cltbld', 21:40:40 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729', 21:40:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:40 INFO - '_': '/tools/buildbot/bin/python'} 21:40:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:40:40 INFO - Running setup.py (path:/tmp/pip-m8PZHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:40:40 INFO - Running setup.py (path:/tmp/pip-yRNXjn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:40:40 INFO - Running setup.py (path:/tmp/pip-xGbM8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:40:40 INFO - Running setup.py (path:/tmp/pip-0IZwLf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:40:40 INFO - Running setup.py (path:/tmp/pip-gxOaxo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:40:40 INFO - Running setup.py (path:/tmp/pip-0E0i6M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:40:40 INFO - Running setup.py (path:/tmp/pip-37BY59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:40:40 INFO - Running setup.py (path:/tmp/pip-cONUqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:40:40 INFO - Running setup.py (path:/tmp/pip-OunZ9h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:40:40 INFO - Running setup.py (path:/tmp/pip-qXVToJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:40:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:40:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:40:40 INFO - Running setup.py (path:/tmp/pip-TguCo9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:40:41 INFO - Running setup.py (path:/tmp/pip-TqYb0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:40:41 INFO - Running setup.py (path:/tmp/pip-Wp4wrf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 21:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:40:41 INFO - Running setup.py (path:/tmp/pip-10VVVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 21:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:40:41 INFO - Running setup.py (path:/tmp/pip-88PoK4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 21:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:40:41 INFO - Running setup.py (path:/tmp/pip-Py7s2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:40:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:40:41 INFO - Running setup.py (path:/tmp/pip-PCCxGO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:40:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:40:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:40:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:40:43 INFO - Downloading blessings-1.6.tar.gz 21:40:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:40:43 INFO - Installing collected packages: blessings 21:40:43 INFO - Running setup.py install for blessings 21:40:43 INFO - Successfully installed blessings 21:40:43 INFO - Cleaning up... 21:40:43 INFO - Return code: 0 21:40:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:40:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:40:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:40:43 INFO - Reading from file tmpfile_stdout 21:40:43 INFO - Current package versions: 21:40:43 INFO - argparse == 1.2.1 21:40:43 INFO - blessings == 1.6 21:40:43 INFO - blobuploader == 1.2.4 21:40:43 INFO - docopt == 0.6.1 21:40:43 INFO - functools32 == 3.2.3-2 21:40:43 INFO - jsonschema == 2.5.1 21:40:43 INFO - manifestparser == 1.1 21:40:43 INFO - mozInstall == 1.12 21:40:43 INFO - mozcrash == 1.0 21:40:43 INFO - mozdebug == 0.1 21:40:43 INFO - mozdevice == 0.50 21:40:43 INFO - mozfile == 1.2 21:40:43 INFO - mozhttpd == 0.7 21:40:43 INFO - mozinfo == 0.9 21:40:43 INFO - mozleak == 0.1 21:40:43 INFO - mozlog == 3.4 21:40:43 INFO - moznetwork == 0.27 21:40:43 INFO - mozprocess == 0.25 21:40:43 INFO - mozprofile == 0.28 21:40:43 INFO - mozrunner == 6.13 21:40:43 INFO - mozscreenshot == 0.1 21:40:43 INFO - mozsystemmonitor == 0.3 21:40:43 INFO - moztest == 0.8 21:40:43 INFO - mozversion == 1.4 21:40:43 INFO - psutil == 3.1.1 21:40:43 INFO - requests == 1.2.3 21:40:43 INFO - wsgiref == 0.1.2 21:40:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:40: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')]} 21:40:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40: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')]} 21:40:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:43 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 0x1e201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bb400>, '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 0x20bc3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bc840>, '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': 'ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:40:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:40:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:40:43 INFO - Using env: {'DISPLAY': ':0', 21:40:43 INFO - 'HOME': '/home/cltbld', 21:40:43 INFO - 'LANG': 'en_US.UTF-8', 21:40:43 INFO - 'LANGUAGE': 'en_US:en', 21:40:43 INFO - 'LOGNAME': 'cltbld', 21:40:43 INFO - 'MAIL': '/var/mail/cltbld', 21:40:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:43 INFO - 'MOZ_NO_REMOTE': '1', 21:40:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:40:43 INFO - 'NO_EM_RESTART': '1', 21:40:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:40:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:43 INFO - 'PWD': '/builds/slave/test', 21:40:43 INFO - 'SHELL': '/bin/bash', 21:40:43 INFO - 'SHLVL': '1', 21:40:43 INFO - 'TERM': 'linux', 21:40:43 INFO - 'TMOUT': '86400', 21:40:43 INFO - 'USER': 'cltbld', 21:40:43 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729', 21:40:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:43 INFO - '_': '/tools/buildbot/bin/python'} 21:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 21:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 21:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 21:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 21:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 21:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 21:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 21:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 21:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 21:40:44 INFO - Cleaning up... 21:40:44 INFO - Return code: 0 21:40:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:40:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:40:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:40:44 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 0x1e201f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e5da80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20be310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20bb400>, '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 0x20bc3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bc840>, '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': 'ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 21:40:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:40:44 INFO - Using env: {'DISPLAY': ':0', 21:40:44 INFO - 'HOME': '/home/cltbld', 21:40:44 INFO - 'LANG': 'en_US.UTF-8', 21:40:44 INFO - 'LANGUAGE': 'en_US:en', 21:40:44 INFO - 'LOGNAME': 'cltbld', 21:40:44 INFO - 'MAIL': '/var/mail/cltbld', 21:40:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:40:44 INFO - 'MOZ_NO_REMOTE': '1', 21:40:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:40:44 INFO - 'NO_EM_RESTART': '1', 21:40:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:40:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:40:44 INFO - 'PWD': '/builds/slave/test', 21:40:44 INFO - 'SHELL': '/bin/bash', 21:40:44 INFO - 'SHLVL': '1', 21:40:44 INFO - 'TERM': 'linux', 21:40:44 INFO - 'TMOUT': '86400', 21:40:44 INFO - 'USER': 'cltbld', 21:40:44 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729', 21:40:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:40:44 INFO - '_': '/tools/buildbot/bin/python'} 21:40:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:40:44 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:40:44 INFO - Cleaning up... 21:40:44 INFO - Return code: 0 21:40:44 INFO - Running post-action listener: _resource_record_post_action 21:40:44 INFO - Running post-action listener: _start_resource_monitoring 21:40:44 INFO - Starting resource monitoring. 21:40:44 INFO - [mozharness: 2017-04-07 04:40:44.436953Z] Finished create-virtualenv step (success) 21:40:44 INFO - [mozharness: 2017-04-07 04:40:44.437408Z] Running install step. 21:40:44 INFO - Running pre-action listener: _resource_record_pre_action 21:40:44 INFO - Running main action method: install 21:40:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:40:44 INFO - Reading from file tmpfile_stdout 21:40:44 INFO - Detecting whether we're running mozinstall >=1.0... 21:40:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:40:44 INFO - Reading from file tmpfile_stdout 21:40:44 INFO - Output received: 21:40:44 INFO - Usage: mozinstall [options] installer 21:40:44 INFO - Options: 21:40:44 INFO - -h, --help show this help message and exit 21:40:44 INFO - -d DEST, --destination=DEST 21:40:44 INFO - Directory to install application into. [default: 21:40:44 INFO - "/builds/slave/test"] 21:40:44 INFO - --app=APP Application being installed. [default: firefox] 21:40:44 INFO - mkdir: /builds/slave/test/build/application 21:40:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:40:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:40:59 INFO - Reading from file tmpfile_stdout 21:40:59 INFO - Output received: 21:40:59 INFO - /builds/slave/test/build/application/firefox/firefox 21:40:59 INFO - Running post-action listener: _resource_record_post_action 21:40:59 INFO - [mozharness: 2017-04-07 04:40:59.957023Z] Finished install step (success) 21:40:59 INFO - [mozharness: 2017-04-07 04:40:59.957299Z] Running run-tests step. 21:40:59 INFO - Running pre-action listener: _resource_record_pre_action 21:40:59 INFO - Running main action method: run_tests 21:40:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:40:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:40:59 INFO - Python 2.7.3 21:40:59 INFO - Return code: 0 21:40:59 INFO - grabbing minidump binary from tooltool 21:40:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:40:59 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 0x20bb400>, '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 0x20bc3b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x20bc840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:40:59 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 21:40:59 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 21:40:59 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 21:41:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:41:00 INFO - Return code: 0 21:41:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:41:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:41:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:41:00 INFO - ENV: RUST_BACKTRACE is now 1 21:41:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:41:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:41:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 21:41:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 21:41:00 INFO - Using env: {'DISPLAY': ':0', 21:41:00 INFO - 'HOME': '/home/cltbld', 21:41:00 INFO - 'LANG': 'en_US.UTF-8', 21:41:00 INFO - 'LANGUAGE': 'en_US:en', 21:41:00 INFO - 'LOGNAME': 'cltbld', 21:41:00 INFO - 'MAIL': '/var/mail/cltbld', 21:41:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:41:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:41:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:41:00 INFO - 'MOZ_NO_REMOTE': '1', 21:41:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:41:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:41:00 INFO - 'NO_EM_RESTART': '1', 21:41:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:41:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:41:00 INFO - 'PWD': '/builds/slave/test', 21:41:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:41:00 INFO - 'RUST_BACKTRACE': '1', 21:41:00 INFO - 'SHELL': '/bin/bash', 21:41:00 INFO - 'SHLVL': '1', 21:41:00 INFO - 'TERM': 'linux', 21:41:00 INFO - 'TMOUT': '86400', 21:41:00 INFO - 'USER': 'cltbld', 21:41:00 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729', 21:41:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:41:00 INFO - '_': '/tools/buildbot/bin/python'} 21:41:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 21:41:00 INFO - mozversion application_buildid: 20170407040155 21:41:00 INFO - mozversion application_changeset: 10ea10d9993c9701e5525928257a589dea2c05d8 21:41:00 INFO - mozversion application_display_name: Nightly 21:41:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:41:00 INFO - mozversion application_name: Firefox 21:41:00 INFO - mozversion application_remotingname: firefox 21:41:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:41:00 INFO - mozversion application_vendor: Mozilla 21:41:00 INFO - mozversion application_version: 55.0a1 21:41:00 INFO - mozversion platform_buildid: 20170407040155 21:41:00 INFO - mozversion platform_changeset: 10ea10d9993c9701e5525928257a589dea2c05d8 21:41:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:41:00 INFO - mozversion platform_version: 55.0a1 21:41:00 INFO - using testdate: 1491540060 21:41:00 INFO - actual date: 1491540060 21:41:00 INFO - starting webserver on 'localhost:39448' 21:41:00 INFO - SUITE-START | Running 2 tests 21:41:00 INFO - TEST-START | dromaeo_css 21:41:00 INFO - operating with platform_type : linux_ 21:41:00 INFO - Initialising browser for dromaeo_css test... 21:41:00 INFO - TEST-INFO | started process 12292 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNgaliE/profile http://localhost:39448/getInfo.html) 21:41:05 INFO - PID 12292 | __metrics Screen width/height:1600/1200 21:41:05 INFO - PID 12292 | colorDepth:24 21:41:05 INFO - PID 12292 | Browser inner width/height: 1024/697 21:41:05 INFO - PID 12292 | __metrics 21:41:06 INFO - PID 12292 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:41:06 INFO - PID 12292 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:41:07 INFO - TEST-INFO | 12292: exit 0 21:41:07 INFO - Browser initialized. 21:41:07 INFO - Running cycle 1/1 for dromaeo_css test... 21:41:07 INFO - TEST-INFO | started process 12396 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNgaliE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:41:19 INFO - PID 12396 | RSS: Main: 170917888 21:41:19 INFO - PID 12396 | 21:44:27 INFO - PID 12396 | Cycle 1(1): loaded http://localhost:39448/tests/dromaeo/cssquery-dojo.html (next: http://localhost:39448/tests/dromaeo/cssquery-ext.html) 21:44:28 INFO - PID 12396 | RSS: Main: 290570240 21:44:28 INFO - PID 12396 | 21:46:08 INFO - PID 12396 | ************************* 21:46:08 INFO - PID 12396 | A coding exception was thrown and uncaught in a Task. 21:46:08 INFO - PID 12396 | 21:46:08 ERROR - PID 12396 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:46:08 INFO - PID 12396 | Full stack: 21:46:08 INFO - PID 12396 | ************************* 21:46:08 INFO - PID 12396 | ************************* 21:46:08 INFO - PID 12396 | A coding exception was thrown and uncaught in a Task. 21:46:08 INFO - PID 12396 | 21:46:08 ERROR - PID 12396 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:46:08 INFO - PID 12396 | Full stack: 21:46:08 INFO - PID 12396 | ************************* 21:46:08 INFO - PID 12396 | ************************* 21:46:08 INFO - PID 12396 | A coding exception was thrown and uncaught in a Task. 21:46:08 INFO - PID 12396 | 21:46:08 ERROR - PID 12396 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:46:08 INFO - PID 12396 | Full stack: 21:46:08 INFO - PID 12396 | ************************* 21:46:08 INFO - PID 12396 | ************************* 21:46:08 INFO - PID 12396 | A coding exception was thrown and uncaught in a Task. 21:46:08 INFO - PID 12396 | 21:46:08 ERROR - PID 12396 | Full message: TypeError: NetworkError when attempting to fetch resource. 21:46:08 INFO - PID 12396 | Full stack: 21:46:08 INFO - PID 12396 | ************************* 21:47:30 INFO - PID 12396 | Cycle 1(1): loaded http://localhost:39448/tests/dromaeo/cssquery-ext.html (next: http://localhost:39448/tests/dromaeo/cssquery-jquery.html) 21:47:31 INFO - PID 12396 | RSS: Main: 264667136 21:47:31 INFO - PID 12396 | 21:50:33 INFO - PID 12396 | Cycle 1(1): loaded http://localhost:39448/tests/dromaeo/cssquery-jquery.html (next: http://localhost:39448/tests/dromaeo/cssquery-mootools.html) 21:50:33 INFO - PID 12396 | RSS: Main: 203198464 21:50:33 INFO - PID 12396 | 21:53:36 INFO - PID 12396 | Cycle 1(1): loaded http://localhost:39448/tests/dromaeo/cssquery-mootools.html (next: http://localhost:39448/tests/dromaeo/cssquery-prototype.html) 21:53:36 INFO - PID 12396 | RSS: Main: 202977280 21:53:36 INFO - PID 12396 | 21:56:39 INFO - PID 12396 | Cycle 1(1): loaded http://localhost:39448/tests/dromaeo/cssquery-prototype.html (next: http://localhost:39448/tests/dromaeo/cssquery-yui.html) 21:56:40 INFO - PID 12396 | RSS: Main: 215666688 21:56:40 INFO - PID 12396 | 21:59:43 INFO - PID 12396 | Cycle 1(1): loaded http://localhost:39448/tests/dromaeo/cssquery-yui.html (next: http://localhost:39448/tests/dromaeo/cssquery-dojo.html) 21:59:43 INFO - PID 12396 | RSS: Main: 293019648 21:59:43 INFO - PID 12396 | 21:59:43 INFO - PID 12396 | __start_tp_report 21:59:43 INFO - PID 12396 | _x_x_mozilla_page_load 21:59:43 INFO - PID 12396 | _x_x_mozilla_page_load_details 21:59:43 INFO - PID 12396 | |i|pagename|runs| 21:59:43 INFO - PID 12396 | |0;dojo.html;2710.349516116132;2747.642806435163;2774.250952242893;2775.45878553682;2801.4677211329854;5180.974095129529;5298.6555873868265;5306.65506742062;5370.624056316059;5417.214503896933;5283.392409872866;5287.101192797224;5312;5315.176147697103;5317.973410132953;4677.204875171229;4689.976550117244;4721.197396442596;4732.1482133216;4755.048990201956;4742.122707299143;4770.570648641621;4785.306130611059;4785.617150627959;4787.8563643090765;4770.85687429376;4773.284007398901;4777.808887644507;4780.737059461728;4784.378030856001;4709.599684026862;4758.809647614108;4760.190767569521;4780.426348838144;4799.472058073609;4772.665913386029;4775.188218002948;4778.928316075262;4778.95221047792;4825.20384136617;5173.120569503193;5174.09453345663;5185.714785686786;5222.556082732972;5247.212918062283;5278.9208161877605;5640.971795141039;5661.405552417019;5717.942820571782;5791.942080579182;5734.082546792535;5738.856528586777;5851.619644723122;5856.355800861902;5865.472107510302;5367.087595108802;5369.731513424314;5372.301600791872;5375.462453754593;5375.5162035417;5943.70281485924;5945.554083443759;5946.524278057745;5951;5955.37468565803;5540.473655002768;5622.522085622686;5629.774809007676;5690.857728556819;5693.202951586781;5753.626014309057;5757.107648314518;5763.279590051244;5763.654180749085;5803.100519419497;5697.344805347355;5699.458551437607;5702.48677619008;5702.6293290935955;5706.514946229534;5583.692896890629;5604.747786349624;5657.405972372924;5673.489385955284;5719;4800.4479484859685;4844.273358996108;4880.438749543777;4900.09348270564;4900.754962251873;4071.3689378146437;4127.587241275848;4138.772367519755;4164.312888373445;4166.1251137261515;4783.736894470768;4881.194602890483;4888.388951381077;4890.853274401774;4897.755112244445;5776.797812076557;5787.565932555075;5803.361630220672;5862.267216597926;5866.090755932837;4869.074875773592;4877.195262781673;4896.020795840775;4897.608191344684;4941.505849415102;5198.740062996911;5207.140821764367;5207.973960130251;5212.270282160501;5214.7914083437;5174.275601415729;5299.549538289134;5299.894002119859;5302.072137376021;5310.203469479609;5772.913406298825;5778.739956702043;5782.017057100219;5783.248177736868;5783.913241301468;5251.212318152155;5314;5314.016906872241;5315.4418786028455;5318.175682769177;5653.717314134195;5658.971705141448;5659.915101273402;5664.518515926193;5667.20659107717;5828.242328497268;5837.416258374298;5844.26946631671;5891.057430811221;5895.174675545512;5491.368492623399;5623.746931388179;5626.803061892814;5632.436756324335;5636.436356364331;5575.99632066232;5596.9440305598055;5603.579731520071;5626.971865140648;5630.324361076697;5412.566994640498;5487.039768040657;5493.945060549343;5515.641483303572;5560.610757246954;5669.603127781016;5672.319321681424;5675.120356344608;5689.089745640677;5723.627964182481;5490.121580547093;5511.200875873056;5536.612437129363;5539.695316757456;5540.889182216252 21:59:43 INFO - PID 12396 | |1;ext.html;631.3370960491486;692.5498426023084;712.0245263988337;936.9812603747921;952.3809523809518;23248.30255092348;32537.51193732093;32895.67104328956;32994.505082423726;33129.66870331296;34725.13187170315;34945.825270873676;35068.64931350686;35083.82458087706;35152;7115.075040244761;7263.164736055342;7265.128184617854;7283.453740969422;7288.489805713602;5365.839024829262;5512.779488820443;6937;7084.787456376292;7091.290870912919;7236.059312289395;7316.524425912298;7319.3046660567425;7320.084989376328;7322.890156647654;7215.530990485628;7247;7268.781936541912;7270.818229544251;7274.1634712008;6988.126484189476;7043.154821421411;7057.647117644097;7061.082059332254;7062.152541694978;31042.689573104206;31310.84344578285;31315.217119571964;31341.37317253665;31347.84326078378;2744.135597286848;2766.045714228608;2766.7509924106926;2769.0308392062616;2770.9445811083665;23614.173503927454;23655.7634423657;23675.526489470285;23686.881565592234;23722.288331350086;3151.8739250429953;3193.888213912502;3205.118592387089;3205.4550726376574;3257.2508323085585;129942;130620.34689826585;130637;130990;131034;38991.41512877309;39076.41385379222;39113.21773564513;39131.804340978684;39176.80411597981;41511.792441038204;41525;41566.79216603898;41571.376429353586;41602.1679566407;10850.945745271381;10910.181736369805;10929.180311476672;10930.234883558074;10941.671749847517;8704.347173961978;8726.607302671395;8744.169303916118;8759.430637008574;8767.649294028295;8667.739967800977;8731.781705457415;8821.558922053871;10224.591016359262;11081.778364432666;4874.95125048745;4901.374179780217;4922;4958.801647934114;4986.501349864984;878.1481962496368;882.6601758323092;893.7363477774072;902.7833320003152;909.9226565741853;18661.90669046673;19979.700304495444;19988.90005549963;20345.186192552133;23876.64185037226;929.9395539289925;951.700928232957;973.6884197057016;975.5366201054584;977.9853302200472;10080.647177348757;10623.415712135908;10625.309354891908;10633.361998279974;10732.624358147428;192625;193460;193835;194157;194271;36340.636593634255;36683.81658091746;36700.63299367025;36720;36760;1197.5030362399507;1246.3020708403324;1247.1768632702554;1247.457356050121;1247.7566874459574;17958.281668733627;17959.47656397947;18568.81431185671;18879.90560047191;19080.618387631894;27506.587401188597;27518.44963100767;27554.448911021267;27619.171424857286;27641;181494.09252954178;181976;182481;182667;182808;25942;26211.475770484863;26279.897608190917;26359;26467.7353226473;23783.167589134297;24119;31575.21061973469;31591.035634743585;32425;23649.462784918924;24505.75494245106;24897.128600498894;25812.612810807477;25879.611805823304;24105.638415424135;24192.395190120387;25042.37394065163;25281.11516096928;25421.364465888502;26676.59985100186;26703.46593068089;26865.731342686322;27008;27361.45277094407;24069;24121.276361709177;24500.142495012587;24762.380940476633;25249.242522724348;19123.61752764909;20017.399478015683;20204.494887627927;20240.392788216377;20265.898670506554 21:59:43 INFO - PID 12396 | |2;jquery.html;411.7796978616439;419.12193953667065;425.91481703659275;436.9191699535586;444.7909482543205;17570.29718811249;17805.64388712225;17951.102444877768;18712.157952892117;18751.531211719714;17099.91450042748;17317.480475585722;17911.462656120304;18336.174872130752;18448.35430759924;5686.857828554288;5740.684262365568;5762.769489220447;5764.077747560391;5804.912926306109;5621.8594535136535;5772.595918285721;5798.768049278024;5804.303483581976;5806.796762113327;5437.13005919053;5599.664020158803;5643.322801263854;5645.379008309083;5773.364929857712;5519.337679478448;5659.320881494226;5683.772649094031;5694.6867922264255;5695.117256825178;5103.336566246364;5160.92258616121;5164.147915593922;5167.121589329823;5167.689938603696;22466.213682521033;22578.548429031493;22802.543949120925;22909.541809163722;23067.423314417105;1607.5900645335482;1641.105597449381;1659.1704147926037;1663.193351224655;1664.950051498445;14286.928565357211;14501.274936253145;14807.925960370128;15009;15106.471273505484;2025.3923822853085;2107.9262225822176;2124.883131427771;2133.669281261407;2154.838387120972;68215;88781.55609221978;90165.54917225438;90470;93948.53025734896;10890.61882834097;10893.237473376947;10981.341119532854;11421.486033128363;11585.131115166396;16143.838561614233;16153;16168.27242774078;16168.919155404148;16190.838091618933;7344.412447004333;7667.731629392944;7695.846083078419;7799.33705635016;7832;6669.666121161396;6726.621042686237;6768.390844823989;6783.559068660521;6983.546069505466;6851.828704282433;6881;6898.620575868375;6906.620135892474;6948.895766563505;1870.2892900697648;1923.1249781349452;1926.5376309685855;2088.968665470019;2197.274899283265;824.7278398128603;839.5424493650975;870.9651613935372;887.3611000079932;898.6854600889636;16413.91793041051;16550.917245413697;16959.491215263562;17026.404075857532;17154.571135721457;861.1990848510819;864.8356812205661;877.8639310906692;880.6873559886276;886.5833058462513;9158.221551168226;9378.390404623678;10640.574377024986;11501;11707.531698731955;466207;467056;475643;483863;486353;87188;91889.39037316086;92749;94231.52884235534;96242.51878740701;1107.545906178479;1113.4711012269108;1133.2010932292715;1135.4833550734395;1138.2885696439726;16510.33958641641;16748;16996.49010529686;17290.567735806704;17632.91183544074;43885.78057109694;43953.78023109864;44314.556854431044;44337;44468.77765611151;56789;56986.43013569977;57077.429225708875;58136.41863581479;58354.4164558349;7316.158641756266;7492.51298665585;7527.849443011219;7670.616469176631;7956.9602151988865;11394.772104557696;11399.772004560029;11942.940285298519;12285.447154877873;12395.070369722487;10101.69694909154;10353.534090966075;10376.377417354983;10409.583616655249;10943.124550036136;9705.223582113273;9926.801463970825;9945.403275803475;10063.899361006297;10190.031946965322;10017.799644007226;10104.848427273744;10117.696469105644;10125.493725313852;10132;7674.117476490275;7837.804054898673;7877.724279650185;7977.641006154621;8091.878621820795;10374.325668831501;10388.272820902464;10392.740181495523;10453.216008799523;10646.20153488507 21:59:43 INFO - PID 12396 | |3;mootools.html;1255.8869701726846;1314.513629956916;1325.8806707396332;1332.9066965312427;1337.4516448256213;9771.902280977189;10169.38983660981;10182.185425165979;10187.185025197976;10188.388696678187;10027;10165.135963443116;10471.057604815565;10492.580296788119;10520.473976301193;2226.1206823304824;2253.4704344479032;2258.762829902861;2271.3980795089233;2279.2706333973133;1841.990790046048;2054.5685406064745;2120.141342756186;2159.1903036361364;2161.5136594266323;1827.9543011424687;2130.6377915754283;2192.550527141932;2200.8679479231296;2208.094681180716;2169.945751356213;2191.8465707400487;2199.6590528468114;2202.8898555072265;2203.2398822406244;2056.506438454775;2062.3091264426284;2064.4735592423986;2064.64900966836;2066.90698918549;9771.511424428822;9933;9962.850557241647;9964.252681048878;9964.90035099647;5278.392984806719;5453.918191227135;5468.125099983983;5470.781168753245;5471.097268950618;3151.6848315168527;3221.1624977505785;3262.494313381406;3263.2494526259093;3279.3769183854993;979.6816034788723;1014.2291858187757;1069.337011053152;1077.5474300793608;1079.1205167788228;14995.250237488082;15196.46812361573;15202.771958420633;15206.391744330214;15208.16355100469;4666.113438446684;4791.6406269529225;4942.9258561121615;5003.324551185543;5047.621428392885;10413.53139108742;10416.843747343795;10435.68692939213;10449.05958463742;10454.581816727397;5314.123169677037;5330.227117068003;5336;5341.145416733304;5346.946530534723;4830.130576496264;4877.439094504178;4895.485973972682;4896.436909755424;5026.195808670668;3818.3317919364;3874.0629685157423;3928.253631809947;4005.539362973237;4007.0583412897945;1084.902358787697;1087.8803331633515;1089.6513115803025;1113.1484414422973;1114.7046032801313;503.59460634189827;538.4561592791309;595.5414330965133;596.3946594206883;608.5983251054283;5451.727413629303;5554.0835762099605;5586.832395028075;5655.264815573949;5791.82624521265;500.4670026421849;505.000099802386;507.3176577503252;509.3404041765922;625.343389441085;3124.703153200442;3204.022773054194;3326.018824446794;3394.0666316763086;3433.1931995980926;12471.563495277622;12987.155834870704;13146.342682865818;13152.868471315356;13156.276404797636;12784.552540661218;13069.346532673328;13141.54004609834;13153;13215.207087574585;9360.719178424659;9394.06059394055;9434.858477122849;9492.288078394009;9506.762330941781;5174.223866419917;5191.792328306826;5224.843254702365;5978.790742323998;6071.150038994632;11653;11910.940445297718;11930.642080737593;11997.64007079789;12063.577774778192;11660.708482288012;11940.76118477643;12060;12080.275183489019;12090.75818483643;7509;7598.924010759822;7693.961530192313;7710.92289077102;7728.7681369559;8531.658733650833;8706.390552661507;8762.824743504967;8774.692885748967;8791.604377802887;7632.1986191451315;7685.692572297045;7738.264864837832;7741.806454838674;7843.411744119328;7402.9629851850395;7513.211112833293;7539.924600753922;7540.924590754242;7600.087989441303;6737.461003119836;6761.3238676132;6769.830754230987;6808.319168083152;6866.553674011173;5090.898182036412;5143.202803565453;5179.171332586919;5199.870003249949;5236.581073514034;4970.701757894538;4992.600591952562;5088.974555127201;5191;5205.479452054764 21:59:43 INFO - PID 12396 | |4;prototype.html;381.1652481066464;383.7505621346125;385.7858888316983;390.85733707196874;397.3126491170277;5272.472752724726;5349.919751203735;5355.277037599923;5375.6774593524415;5381.273528073709;4971.279164521142;5213.113770658988;5236.1098613235745;5244.505315984945;5269.473052694729;4017.2926506234735;4024.1146947671537;4025.134596061846;4032.5564187939303;4036.0717035081802;4020.7989600520004;4025.5974402559655;4028.858989935353;4032.899177520556;4032.9395059074136;3991.6407523322896;3999.440078389028;4001.899952501182;4005.5994400559857;4005.939910901339;3814.370628846237;3960.1683646434426;3991.4012898065234;4005.8998525036814;4010.455974449829;3488.372093023255;3494.9126271843406;3505.8247087645773;3509.78941263525;3513.4905438711244;5067.417247016603;5095.923561146586;5107.3360463139925;5112.667676601046;5114.897702045975;4518.796654150571;4680.4383473983;4734.692245004064;4737.749568954719;4743.217369134089;5547.696291371524;5563.332400111972;5575.386707462176;5576.302962129734;5581.7209139543265;3937.3503371943593;3945.5857135000697;3945.8027098644952;3953.802309884523;3954.1103251768122;5804.8839023219725;5867.207926929853;5932.288125424933;5940.910886336708;5962.731677074586;4322.502912165079;4340.110277393127;4359.8581347719155;4366.628836548929;4372.475302963665;4411.691181617321;4424.247877860771;4427.313766366218;4433.246348120827;4436.179306828247;4745.14587374269;4901;4909.705417674951;4915.631327650369;4933.407991041098;5608.878224355064;5629.211910332557;5639.43605639441;5648.74580643872;5652.9152062719095;1508.3815635589574;1531.6477210241708;1531.8851086168581;1531.9846801532065;1537.2237020304674;1015.1422048369117;1056.8837427882927;1059.1526778577108;1066.1151244467073;1076.520948178069;4897.118518666674;4897.1674815281485;4904.828331008398;4914.189158788831;4917.164082106051;5794.62334948227;5803.259022293295;5830.47525722687;5850.180974663551;5855.180274761537;4696.131215725101;4876.268559716071;4908.300434760868;4908.435529914105;4912.4350699669285;3047.8628461719277;3065.7700672449655;3082.9537556936666;3085.46004449225;3089.891853785152;5311.840644780663;5329.786808527693;5341.878205576794;5348.251244825728;5357.651752636066;5650.858728531737;5762.971185144047;5913.6936594728095;5926.940730592725;5966.134910437962;5203.635745497854;5242.239875218072;5307.734613269321;5321.122014867504;5368.355797304349;5825.446582574648;5827.329857066492;5829.883402332014;5831.562632802472;5833.67914764692;5548.528375088163;5665.546756259571;5675.687837168995;5716.828495145152;5728.312602487728;5342.171963345688;5353.4646535346155;5355.625106242525;5356.732163391737;5372.704501252469;4363.3018717005125;4363.520012798653;4368.956310436982;4371.388005679271;4372.562743725729;5602.635828671123;5791.739371728367;5817.447342502455;5820.854478638068;5835.824925252249;5599.832005039855;5600.767831077156;5615.213870058276;5628.409017053151;5649.237352957298;5491.066518691752;5610.971945140248;5641.476801263718;5649.457744015292;5666.603337766317;5557.610967232255;5566.888662226652;5571.693556854412;5575.135853942646;5578.832635020955;5684.459976302244;5685;5689.402612725604;5699.943000570107;5702.971485142713;5334.653247538898;5519.227308176939;5531.308586426697;5533.972330138324;5545.694986775766 21:59:43 INFO - PID 12396 | |5;yui.html;647.4270270810331;662.6719773712014;678.5453745990186;700.1842853076166;700.800271922502;12164.087693422984;12738;13271.20372777634;13272.668183295422;13280.667983300422;12669.936650316735;13000.674983125427;13000.869991300084;13018.088733788638;13018.153820001717;826.6445428465757;828.1801016993163;847.2840449819893;851.3870013590237;853.7097386888456;850.4897061762923;850.740524140137;851.7657644147847;852.5992783391796;855.7261676263598;879.3009557401849;879.4107947675041;880.2341962492641;880.7886107334226;885.2033170146888;879.2306731609841;879.4986857491233;880.4277219807112;880.520116536486;885.9867101993475;642.2678146912524;646.0212777641876;647.8866198415259;649.9902501462482;652.670401447266;12865;13115.606531804062;13134.934325328408;13219.471221151143;13247.07270491066;13397.062205645609;13853.030287879852;13924.627346110017;13934.442622295095;14029.158250505003;10372.273940824145;10794.5682172713;10879.12966962641;10883.619073332395;10946;2767.2805070681566;2828.6888442271334;2853.1155341844096;2878;2879.1794338613395;60685.39314606842;60942.76094276098;61147;62267.37732622661;63359.6832015837;10135.594576217016;10271.702457031703;10312.123469505175;10489.370637761758;10542.209334299958;19715.901420492806;20201.191952321744;20539.691904621443;20596;20691.58616827655;6374.171357723466;6392.296847346788;6507.804765857032;6646.96676516624;6842.452603791685;3235.1103446551915;3359.445691460882;3367.461206206995;3376.6623337666038;3415.7438192135687;3435.158386195398;3487.9302413952087;3502.422100353464;3506.053365591276;3512.964870351315;677.7322957431787;677.8373190434359;685.2770327304742;686.9759558415532;687.4053943338976;498.7930009046205;499.29848562769365;512.6770134815042;533.842516457646;536.1341433584732;7535.434842386733;7804.960975195201;8061.717839875693;8574.485530868167;9363;536.484974424549;541.7887024060619;547.654977364266;551.4926267833603;552.4447929830494;3587.5286410831154;3854.383298672199;3884.2425726983533;3897.2984862724984;4012.197560487914;58399;59499;59646.403535964084;60498.69750651219;61958.38041619616;49385;49926.750366247936;50040;51404.742976285626;52252.47747522476;45876.541234587225;45947;46338.30492542682;46935.295970560466;48506.27240591394;8703.303735701254;9001.414908031218;9145.5884485197;9179.127982841886;9181.586828592863;26056.73943260619;26469.60295595529;26861.86569067142;26862.194134176007;27674.584881226394;31967.68032319647;32233.838830805696;32504.83747581247;32776.180595485304;33193.336133276716;10715.24993250465;11042.227044106836;11079.113670906147;11118.555257789598;11306;11343.602973895873;11582.94208528952;11589.6523104307;11755.588554400554;11772.646820595395;10216.948915255376;10707.250492465453;10804.405757683402;11102.000819926245;11103.278286911325;10732.678019659423;10838.837417438903;10876.891231087588;10921;10929.398883061507;10164.491775411348;10215.693529194135;10216.489175541343;10440.321379110334;10884.78230435371;7965.601719914097;8149.796255093433;8512.40413171072;8638.524881131598;8992.145746154105;9631.677161190024;9712;9773.718783228973;9775.560099795384;9872.851907221253 21:59:43 INFO - PID 12396 | __end_tp_report 21:59:43 INFO - PID 12396 | __start_cc_report 21:59:43 INFO - PID 12396 | _x_x_mozilla_cycle_collect,1188 21:59:43 INFO - PID 12396 | __end_cc_report 21:59:43 INFO - PID 12396 | __startTimestamp1491541183473__endTimestamp 21:59:43 INFO - PID 12396 | 21:59:43 INFO - PID 12396 | ------- Summary: start ------- 21:59:43 INFO - PID 12396 | Number of tests: 6 21:59:43 INFO - PID 12396 | 21:59:43 INFO - PID 12396 | [#0] dojo.html Cycles:165 Average:5256.95 Median:5372.30 stddev:619.27 (11.5%) stddev-sans-first:588.06 21:59:43 INFO - PID 12396 | Values: 2710.3 2747.6 2774.3 2775.5 2801.5 5181.0 5298.7 5306.7 5370.6 5417.2 5283.4 5287.1 5312.0 5315.2 5318.0 4677.2 4690.0 4721.2 4732.1 4755.0 4742.1 4770.6 4785.3 4785.6 4787.9 4770.9 4773.3 4777.8 4780.7 4784.4 4709.6 4758.8 4760.2 4780.4 4799.5 4772.7 4775.2 4778.9 4779.0 4825.2 5173.1 5174.1 5185.7 5222.6 5247.2 5278.9 5641.0 5661.4 5717.9 5791.9 5734.1 5738.9 5851.6 5856.4 5865.5 5367.1 5369.7 5372.3 5375.5 5375.5 5943.7 5945.6 5946.5 5951.0 5955.4 5540.5 5622.5 5629.8 5690.9 5693.2 5753.6 5757.1 5763.3 5763.7 5803.1 5697.3 5699.5 5702.5 5702.6 5706.5 5583.7 5604.7 5657.4 5673.5 5719.0 4800.4 4844.3 4880.4 4900.1 4900.8 4071.4 4127.6 4138.8 4164.3 4166.1 4783.7 4881.2 4888.4 4890.9 4897.8 5776.8 5787.6 5803.4 5862.3 5866.1 4869.1 4877.2 4896.0 4897.6 4941.5 5198.7 5207.1 5208.0 5212.3 5214.8 5174.3 5299.5 5299.9 5302.1 5310.2 5772.9 5778.7 5782.0 5783.2 5783.9 5251.2 5314.0 5314.0 5315.4 5318.2 5653.7 5659.0 5659.9 5664.5 5667.2 5828.2 5837.4 5844.3 5891.1 5895.2 5491.4 5623.7 5626.8 5632.4 5636.4 5576.0 5596.9 5603.6 5627.0 5630.3 5412.6 5487.0 5493.9 5515.6 5560.6 5669.6 5672.3 5675.1 5689.1 5723.6 5490.1 5511.2 5536.6 5539.7 5540.9 21:59:43 INFO - PID 12396 | 21:59:43 INFO - PID 12396 | [#1] ext.html Cycles:180 Average:29924.29 Median:31176.77 stddev:44413.46 (142.5%) stddev-sans-first:44483.59 21:59:43 INFO - PID 12396 | Values: 631.3 692.5 712.0 937.0 952.4 23248.3 32537.5 32895.7 32994.5 33129.7 34725.1 34945.8 35068.6 35083.8 35152.0 7115.1 7263.2 7265.1 7283.5 7288.5 5365.8 5512.8 6937.0 7084.8 7091.3 7236.1 7316.5 7319.3 7320.1 7322.9 7215.5 7247.0 7268.8 7270.8 7274.2 6988.1 7043.2 7057.6 7061.1 7062.2 31042.7 31310.8 31315.2 31341.4 31347.8 2744.1 2766.0 2766.8 2769.0 2770.9 23614.2 23655.8 23675.5 23686.9 23722.3 3151.9 3193.9 3205.1 3205.5 3257.3 129942.0 130620.3 130637.0 130990.0 131034.0 38991.4 39076.4 39113.2 39131.8 39176.8 41511.8 41525.0 41566.8 41571.4 41602.2 10850.9 10910.2 10929.2 10930.2 10941.7 8704.3 8726.6 8744.2 8759.4 8767.6 8667.7 8731.8 8821.6 10224.6 11081.8 4875.0 4901.4 4922.0 4958.8 4986.5 878.1 882.7 893.7 902.8 909.9 18661.9 19979.7 19988.9 20345.2 23876.6 929.9 951.7 973.7 975.5 978.0 10080.6 10623.4 10625.3 10633.4 10732.6 192625.0 193460.0 193835.0 194157.0 194271.0 36340.6 36683.8 36700.6 36720.0 36760.0 1197.5 1246.3 1247.2 1247.5 1247.8 17958.3 17959.5 18568.8 18879.9 19080.6 27506.6 27518.4 27554.4 27619.2 27641.0 181494.1 181976.0 182481.0 182667.0 182808.0 25942.0 26211.5 26279.9 26359.0 26467.7 23783.2 24119.0 31575.2 31591.0 32425.0 23649.5 24505.8 24897.1 25812.6 25879.6 24105.6 24192.4 25042.4 25281.1 25421.4 26676.6 26703.5 26865.7 27008.0 27361.5 24069.0 24121.3 24500.1 24762.4 25249.2 19123.6 20017.4 20204.5 20240.4 20265.9 21:59:43 INFO - PID 12396 | 21:59:43 INFO - PID 12396 | [#2] jquery.html Cycles:180 Average:28557.26 Median:44134.17 stddev:78734.09 (178.4%) stddev-sans-first:78926.59 21:59:43 INFO - PID 12396 | Values: 411.8 419.1 425.9 436.9 444.8 17570.3 17805.6 17951.1 18712.2 18751.5 17099.9 17317.5 17911.5 18336.2 18448.4 5686.9 5740.7 5762.8 5764.1 5804.9 5621.9 5772.6 5798.8 5804.3 5806.8 5437.1 5599.7 5643.3 5645.4 5773.4 5519.3 5659.3 5683.8 5694.7 5695.1 5103.3 5160.9 5164.1 5167.1 5167.7 22466.2 22578.5 22802.5 22909.5 23067.4 1607.6 1641.1 1659.2 1663.2 1665.0 14286.9 14501.3 14807.9 15009.0 15106.5 2025.4 2107.9 2124.9 2133.7 2154.8 68215.0 88781.6 90165.5 90470.0 93948.5 10890.6 10893.2 10981.3 11421.5 11585.1 16143.8 16153.0 16168.3 16168.9 16190.8 7344.4 7667.7 7695.8 7799.3 7832.0 6669.7 6726.6 6768.4 6783.6 6983.5 6851.8 6881.0 6898.6 6906.6 6948.9 1870.3 1923.1 1926.5 2089.0 2197.3 824.7 839.5 871.0 887.4 898.7 16413.9 16550.9 16959.5 17026.4 17154.6 861.2 864.8 877.9 880.7 886.6 9158.2 9378.4 10640.6 11501.0 11707.5 466207.0 467056.0 475643.0 483863.0 486353.0 87188.0 91889.4 92749.0 94231.5 96242.5 1107.5 1113.5 1133.2 1135.5 1138.3 16510.3 16748.0 16996.5 17290.6 17632.9 43885.8 43953.8 44314.6 44337.0 44468.8 56789.0 56986.4 57077.4 58136.4 58354.4 7316.2 7492.5 7527.8 7670.6 7957.0 11394.8 11399.8 11942.9 12285.4 12395.1 10101.7 10353.5 10376.4 10409.6 10943.1 9705.2 9926.8 9945.4 10063.9 10190.0 10017.8 10104.8 10117.7 10125.5 10132.0 7674.1 7837.8 7877.7 7977.6 8091.9 10374.3 10388.3 10392.7 10453.2 10646.2 21:59:43 INFO - PID 12396 | 21:59:43 INFO - PID 12396 | [#3] mootools.html Cycles:180 Average:6149.40 Median:3966.90 stddev:4026.22 (101.5%) stddev-sans-first:4020.72 21:59:43 INFO - PID 12396 | Values: 1255.9 1314.5 1325.9 1332.9 1337.5 9771.9 10169.4 10182.2 10187.2 10188.4 10027.0 10165.1 10471.1 10492.6 10520.5 2226.1 2253.5 2258.8 2271.4 2279.3 1842.0 2054.6 2120.1 2159.2 2161.5 1828.0 2130.6 2192.6 2200.9 2208.1 2169.9 2191.8 2199.7 2202.9 2203.2 2056.5 2062.3 2064.5 2064.6 2066.9 9771.5 9933.0 9962.9 9964.3 9964.9 5278.4 5453.9 5468.1 5470.8 5471.1 3151.7 3221.2 3262.5 3263.2 3279.4 979.7 1014.2 1069.3 1077.5 1079.1 14995.3 15196.5 15202.8 15206.4 15208.2 4666.1 4791.6 4942.9 5003.3 5047.6 10413.5 10416.8 10435.7 10449.1 10454.6 5314.1 5330.2 5336.0 5341.1 5346.9 4830.1 4877.4 4895.5 4896.4 5026.2 3818.3 3874.1 3928.3 4005.5 4007.1 1084.9 1087.9 1089.7 1113.1 1114.7 503.6 538.5 595.5 596.4 608.6 5451.7 5554.1 5586.8 5655.3 5791.8 500.5 505.0 507.3 509.3 625.3 3124.7 3204.0 3326.0 3394.1 3433.2 12471.6 12987.2 13146.3 13152.9 13156.3 12784.6 13069.3 13141.5 13153.0 13215.2 9360.7 9394.1 9434.9 9492.3 9506.8 5174.2 5191.8 5224.8 5978.8 6071.2 11653.0 11910.9 11930.6 11997.6 12063.6 11660.7 11940.8 12060.0 12080.3 12090.8 7509.0 7598.9 7694.0 7710.9 7728.8 8531.7 8706.4 8762.8 8774.7 8791.6 7632.2 7685.7 7738.3 7741.8 7843.4 7403.0 7513.2 7539.9 7540.9 7600.1 6737.5 6761.3 6769.8 6808.3 6866.6 5090.9 5143.2 5179.2 5199.9 5236.6 4970.7 4992.6 5089.0 5191.0 5205.5 21:59:43 INFO - PID 12396 | 21:59:43 INFO - PID 12396 | [#4] prototype.html Cycles:180 Average:4656.51 Median:5159.27 stddev:1337.24 (25.9%) stddev-sans-first:1301.92 21:59:43 INFO - PID 12396 | Values: 381.2 383.8 385.8 390.9 397.3 5272.5 5349.9 5355.3 5375.7 5381.3 4971.3 5213.1 5236.1 5244.5 5269.5 4017.3 4024.1 4025.1 4032.6 4036.1 4020.8 4025.6 4028.9 4032.9 4032.9 3991.6 3999.4 4001.9 4005.6 4005.9 3814.4 3960.2 3991.4 4005.9 4010.5 3488.4 3494.9 3505.8 3509.8 3513.5 5067.4 5095.9 5107.3 5112.7 5114.9 4518.8 4680.4 4734.7 4737.7 4743.2 5547.7 5563.3 5575.4 5576.3 5581.7 3937.4 3945.6 3945.8 3953.8 3954.1 5804.9 5867.2 5932.3 5940.9 5962.7 4322.5 4340.1 4359.9 4366.6 4372.5 4411.7 4424.2 4427.3 4433.2 4436.2 4745.1 4901.0 4909.7 4915.6 4933.4 5608.9 5629.2 5639.4 5648.7 5652.9 1508.4 1531.6 1531.9 1532.0 1537.2 1015.1 1056.9 1059.2 1066.1 1076.5 4897.1 4897.2 4904.8 4914.2 4917.2 5794.6 5803.3 5830.5 5850.2 5855.2 4696.1 4876.3 4908.3 4908.4 4912.4 3047.9 3065.8 3083.0 3085.5 3089.9 5311.8 5329.8 5341.9 5348.3 5357.7 5650.9 5763.0 5913.7 5926.9 5966.1 5203.6 5242.2 5307.7 5321.1 5368.4 5825.4 5827.3 5829.9 5831.6 5833.7 5548.5 5665.5 5675.7 5716.8 5728.3 5342.2 5353.5 5355.6 5356.7 5372.7 4363.3 4363.5 4369.0 4371.4 4372.6 5602.6 5791.7 5817.4 5820.9 5835.8 5599.8 5600.8 5615.2 5628.4 5649.2 5491.1 5611.0 5641.5 5649.5 5666.6 5557.6 5566.9 5571.7 5575.1 5578.8 5684.5 5685.0 5689.4 5699.9 5703.0 5334.7 5519.2 5531.3 5534.0 5545.7 21:59:43 INFO - PID 12396 | 21:59:43 INFO - PID 12396 | [#5] yui.html Cycles:180 Average:13595.64 Median:45911.77 stddev:16393.63 (35.7%) stddev-sans-first:16410.79 21:59:43 INFO - PID 12396 | Values: 647.4 662.7 678.5 700.2 700.8 12164.1 12738.0 13271.2 13272.7 13280.7 12669.9 13000.7 13000.9 13018.1 13018.2 826.6 828.2 847.3 851.4 853.7 850.5 850.7 851.8 852.6 855.7 879.3 879.4 880.2 880.8 885.2 879.2 879.5 880.4 880.5 886.0 642.3 646.0 647.9 650.0 652.7 12865.0 13115.6 13134.9 13219.5 13247.1 13397.1 13853.0 13924.6 13934.4 14029.2 10372.3 10794.6 10879.1 10883.6 10946.0 2767.3 2828.7 2853.1 2878.0 2879.2 60685.4 60942.8 61147.0 62267.4 63359.7 10135.6 10271.7 10312.1 10489.4 10542.2 19715.9 20201.2 20539.7 20596.0 20691.6 6374.2 6392.3 6507.8 6647.0 6842.5 3235.1 3359.4 3367.5 3376.7 3415.7 3435.2 3487.9 3502.4 3506.1 3513.0 677.7 677.8 685.3 687.0 687.4 498.8 499.3 512.7 533.8 536.1 7535.4 7805.0 8061.7 8574.5 9363.0 536.5 541.8 547.7 551.5 552.4 3587.5 3854.4 3884.2 3897.3 4012.2 58399.0 59499.0 59646.4 60498.7 61958.4 49385.0 49926.8 50040.0 51404.7 52252.5 45876.5 45947.0 46338.3 46935.3 48506.3 8703.3 9001.4 9145.6 9179.1 9181.6 26056.7 26469.6 26861.9 26862.2 27674.6 31967.7 32233.8 32504.8 32776.2 33193.3 10715.2 11042.2 11079.1 11118.6 11306.0 11343.6 11582.9 11589.7 11755.6 11772.6 10216.9 10707.3 10804.4 11102.0 11103.3 10732.7 10838.8 10876.9 10921.0 10929.4 10164.5 10215.7 10216.5 10440.3 10884.8 7965.6 8149.8 8512.4 8638.5 8992.1 9631.7 9712.0 9773.7 9775.6 9872.9 21:59:43 INFO - PID 12396 | -------- Summary: end -------- 21:59:43 INFO - PID 12396 | 21:59:44 INFO - TEST-INFO | 12396: exit 0 21:59:44 INFO - TEST-OK | dromaeo_css | took 1124114ms 21:59:44 INFO - TEST-START | kraken 21:59:44 INFO - operating with platform_type : linux_ 21:59:44 INFO - Initialising browser for kraken test... 21:59:44 INFO - TEST-INFO | started process 12725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNS2G2u/profile http://localhost:39448/getInfo.html) 21:59:48 INFO - PID 12725 | __metrics Screen width/height:1600/1200 21:59:48 INFO - PID 12725 | colorDepth:24 21:59:48 INFO - PID 12725 | Browser inner width/height: 1024/697 21:59:48 INFO - PID 12725 | __metrics 21:59:50 INFO - PID 12725 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:59:50 INFO - PID 12725 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:59:51 INFO - TEST-INFO | 12725: exit 0 21:59:51 INFO - Browser initialized. 21:59:51 INFO - Running cycle 1/1 for kraken test... 21:59:51 INFO - TEST-INFO | started process 12827 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNS2G2u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:00:03 INFO - PID 12827 | RSS: Main: 171491328 22:00:03 INFO - PID 12827 | 22:00:06 INFO - PID 12827 | Cycle 1(1): loaded http://localhost:39448/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:39448/tests/kraken/driver.html?testName=audio-beat-detection) 22:00:07 INFO - PID 12827 | RSS: Main: 231096320 22:00:07 INFO - PID 12827 | 22:00:10 INFO - PID 12827 | Cycle 1(1): loaded http://localhost:39448/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:39448/tests/kraken/driver.html?testName=audio-dft) 22:00:10 INFO - PID 12827 | RSS: Main: 209555456 22:00:10 INFO - PID 12827 | 22:00:13 INFO - PID 12827 | Cycle 1(1): loaded http://localhost:39448/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:39448/tests/kraken/driver.html?testName=audio-fft) 22:00:14 INFO - PID 12827 | RSS: Main: 292876288 22:00:14 INFO - PID 12827 | 22:00:16 INFO - PID 12827 | Cycle 1(1): loaded http://localhost:39448/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:39448/tests/kraken/driver.html?testName=audio-oscillator) 22:00:17 INFO - PID 12827 | RSS: Main: 204148736 22:00:17 INFO - PID 12827 | 22:00:19 INFO - PID 12827 | Cycle 1(1): loaded http://localhost:39448/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:39448/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:00:20 INFO - PID 12827 | RSS: Main: 208224256 22:00:20 INFO - PID 12827 | 22:00:23 INFO - PID 12827 | Cycle 1(1): loaded http://localhost:39448/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:39448/tests/kraken/driver.html?testName=imaging-darkroom) 22:00:24 INFO - PID 12827 | RSS: Main: 246837248 22:00:24 INFO - PID 12827 | 22:00:27 INFO - PID 12827 | Cycle 1(1): loaded http://localhost:39448/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:39448/tests/kraken/driver.html?testName=imaging-desaturate) 22:00:28 INFO - PID 12827 | RSS: Main: 238469120 22:00:28 INFO - PID 12827 | 22:00:31 INFO - PID 12827 | Cycle 1(1): loaded http://localhost:39448/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:39448/tests/kraken/driver.html?testName=json-parse-financial) 22:00:31 INFO - PID 12827 | RSS: Main: 244264960 22:00:31 INFO - PID 12827 | 22:00:33 INFO - PID 12827 | Cycle 1(1): loaded http://localhost:39448/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:39448/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:00:34 INFO - PID 12827 | RSS: Main: 207187968 22:00:34 INFO - PID 12827 | 22:00:35 INFO - PID 12827 | Cycle 1(1): loaded http://localhost:39448/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:39448/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:00:36 INFO - PID 12827 | RSS: Main: 215539712 22:00:36 INFO - PID 12827 | 22:00:38 INFO - PID 12827 | Cycle 1(1): loaded http://localhost:39448/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:39448/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:00:39 INFO - PID 12827 | RSS: Main: 223928320 22:00:39 INFO - PID 12827 | 22:00:42 INFO - PID 12827 | Cycle 1(1): loaded http://localhost:39448/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:39448/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:00:43 INFO - PID 12827 | RSS: Main: 232505344 22:00:43 INFO - PID 12827 | 22:00:46 INFO - PID 12827 | Cycle 1(1): loaded http://localhost:39448/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:39448/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:00:46 INFO - PID 12827 | RSS: Main: 229965824 22:00:46 INFO - PID 12827 | 22:00:48 INFO - PID 12827 | Cycle 1(1): loaded http://localhost:39448/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:39448/tests/kraken/driver.html?testName=ai-astar) 22:00:48 INFO - PID 12827 | RSS: Main: 298266624 22:00:48 INFO - PID 12827 | 22:00:48 INFO - PID 12827 | __start_tp_report 22:00:48 INFO - PID 12827 | _x_x_mozilla_page_load 22:00:48 INFO - PID 12827 | _x_x_mozilla_page_load_details 22:00:48 INFO - PID 12827 | |i|pagename|runs| 22:00:48 INFO - PID 12827 | |0;ai-astar;110;110;112;114;112;112;112;111;112;111 22:00:48 INFO - PID 12827 | |1;audio-beat-detection;148;130;121;172;126;129;124;123;152;124 22:00:48 INFO - PID 12827 | |2;audio-dft;164;162;164;164;165;163;165;168;168;164 22:00:48 INFO - PID 12827 | |3;audio-fft;75;76;75;116;76;75;75;75;92;76 22:00:48 INFO - PID 12827 | |4;audio-oscillator;85;84;122;86;83;84;110;84;84;115 22:00:48 INFO - PID 12827 | |5;imaging-gaussian-blur;113;114;114;114;114;114;115;114;113;114 22:00:48 INFO - PID 12827 | |6;imaging-darkroom;151;151;151;153;150;155;150;151;151;151 22:00:48 INFO - PID 12827 | |7;imaging-desaturate;96;95;95;98;95;95;95;95;94;95 22:00:48 INFO - PID 12827 | |8;json-parse-financial;53;52;52;51;53;53;53;52;54;53 22:00:48 INFO - PID 12827 | |9;json-stringify-tinderbox;55;55;55;57;55;55;56;56;56;56 22:00:48 INFO - PID 12827 | |10;stanford-crypto-aes;90;85;84;86;84;84;86;85;97;85 22:00:48 INFO - PID 12827 | |11;stanford-crypto-ccm;137;135;142;145;135;138;140;142;188;140 22:00:48 INFO - PID 12827 | |12;stanford-crypto-pbkdf2;186;197;197;192;194;195;193;195;194;194 22:00:48 INFO - PID 12827 | |13;stanford-crypto-sha256-iterative;73;71;76;74;73;74;70;72;71;70 22:00:48 INFO - PID 12827 | __end_tp_report 22:00:48 INFO - PID 12827 | __start_cc_report 22:00:48 INFO - PID 12827 | _x_x_mozilla_cycle_collect,1989 22:00:48 INFO - PID 12827 | __end_cc_report 22:00:48 INFO - PID 12827 | __startTimestamp1491541248953__endTimestamp 22:00:48 INFO - PID 12827 | 22:00:48 INFO - PID 12827 | ------- Summary: start ------- 22:00:48 INFO - PID 12827 | Number of tests: 14 22:00:48 INFO - PID 12827 | 22:00:48 INFO - PID 12827 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:1.17 (1.0%) stddev-sans-first:1.09 22:00:48 INFO - PID 12827 | Values: 110.0 110.0 112.0 114.0 112.0 112.0 112.0 111.0 112.0 111.0 22:00:48 INFO - PID 12827 | 22:00:48 INFO - PID 12827 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:129.50 stddev:16.84 (13.0%) stddev-sans-first:17.18 22:00:48 INFO - PID 12827 | Values: 148.0 130.0 121.0 172.0 126.0 129.0 124.0 123.0 152.0 124.0 22:00:48 INFO - PID 12827 | 22:00:48 INFO - PID 12827 | [#2] audio-dft Cycles:10 Average:164.70 Median:164.50 stddev:1.95 (1.2%) stddev-sans-first:2.05 22:00:48 INFO - PID 12827 | Values: 164.0 162.0 164.0 164.0 165.0 163.0 165.0 168.0 168.0 164.0 22:00:48 INFO - PID 12827 | 22:00:48 INFO - PID 12827 | [#3] audio-fft Cycles:10 Average:81.10 Median:75.50 stddev:13.34 (17.7%) stddev-sans-first:13.96 22:00:48 INFO - PID 12827 | Values: 75.0 76.0 75.0 116.0 76.0 75.0 75.0 75.0 92.0 76.0 22:00:48 INFO - PID 12827 | 22:00:48 INFO - PID 12827 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:84.00 stddev:15.44 (18.4%) stddev-sans-first:16.05 22:00:48 INFO - PID 12827 | Values: 85.0 84.0 122.0 86.0 83.0 84.0 110.0 84.0 84.0 115.0 22:00:48 INFO - PID 12827 | 22:00:48 INFO - PID 12827 | [#5] imaging-gaussian-blur Cycles:10 Average:113.90 Median:114.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 22:00:48 INFO - PID 12827 | Values: 113.0 114.0 114.0 114.0 114.0 114.0 115.0 114.0 113.0 114.0 22:00:48 INFO - PID 12827 | 22:00:48 INFO - PID 12827 | [#6] imaging-darkroom Cycles:10 Average:151.40 Median:151.00 stddev:1.51 (1.0%) stddev-sans-first:1.59 22:00:48 INFO - PID 12827 | Values: 151.0 151.0 151.0 153.0 150.0 155.0 150.0 151.0 151.0 151.0 22:00:48 INFO - PID 12827 | 22:00:48 INFO - PID 12827 | [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:1.06 (1.1%) stddev-sans-first:1.09 22:00:48 INFO - PID 12827 | Values: 96.0 95.0 95.0 98.0 95.0 95.0 95.0 95.0 94.0 95.0 22:00:48 INFO - PID 12827 | 22:00:48 INFO - PID 12827 | [#8] json-parse-financial Cycles:10 Average:52.60 Median:53.00 stddev:0.84 (1.6%) stddev-sans-first:0.88 22:00:48 INFO - PID 12827 | Values: 53.0 52.0 52.0 51.0 53.0 53.0 53.0 52.0 54.0 53.0 22:00:48 INFO - PID 12827 | 22:00:48 INFO - PID 12827 | [#9] json-stringify-tinderbox Cycles:10 Average:55.60 Median:56.00 stddev:0.70 (1.2%) stddev-sans-first:0.71 22:00:48 INFO - PID 12827 | Values: 55.0 55.0 55.0 57.0 55.0 55.0 56.0 56.0 56.0 56.0 22:00:48 INFO - PID 12827 | 22:00:48 INFO - PID 12827 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:85.50 stddev:4.06 (4.7%) stddev-sans-first:4.12 22:00:48 INFO - PID 12827 | Values: 90.0 85.0 84.0 86.0 84.0 84.0 86.0 85.0 97.0 85.0 22:00:48 INFO - PID 12827 | 22:00:48 INFO - PID 12827 | [#11] stanford-crypto-ccm Cycles:10 Average:144.20 Median:141.00 stddev:15.72 (11.1%) stddev-sans-first:16.45 22:00:48 INFO - PID 12827 | Values: 137.0 135.0 142.0 145.0 135.0 138.0 140.0 142.0 188.0 140.0 22:00:48 INFO - PID 12827 | 22:00:48 INFO - PID 12827 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.70 Median:194.50 stddev:3.13 (1.6%) stddev-sans-first:1.67 22:00:48 INFO - PID 12827 | Values: 186.0 197.0 197.0 192.0 194.0 195.0 193.0 195.0 194.0 194.0 22:00:48 INFO - PID 12827 | 22:00:48 INFO - PID 12827 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.40 Median:73.00 stddev:1.96 (2.7%) stddev-sans-first:2.06 22:00:48 INFO - PID 12827 | Values: 73.0 71.0 76.0 74.0 73.0 74.0 70.0 72.0 71.0 70.0 22:00:48 INFO - PID 12827 | -------- Summary: end -------- 22:00:48 INFO - PID 12827 | 22:00:50 INFO - TEST-INFO | 12827: exit 0 22:00:50 INFO - TEST-OK | kraken | took 66007ms 22:00:50 INFO - SUITE-END | took 1190s 22:00:50 INFO - Completed test suite (00:19:50) 22:00:50 INFO - javascript benchmark 22:00:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6508.619233824741, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2710.349516116132, 2747.642806435163, 2774.250952242893, 2775.45878553682, 2801.4677211329854, 5180.974095129529, 5298.6555873868265, 5306.65506742062, 5370.624056316059, 5417.214503896933, 5283.392409872866, 5287.101192797224, 5312.0, 5315.176147697103, 5317.973410132953, 4677.204875171229, 4689.976550117244, 4721.197396442596, 4732.1482133216, 4755.048990201956, 4742.122707299143, 4770.570648641621, 4785.306130611059, 4785.617150627959, 4787.8563643090765, 4770.85687429376, 4773.284007398901, 4777.808887644507, 4780.737059461728, 4784.378030856001, 4709.599684026862, 4758.809647614108, 4760.190767569521, 4780.426348838144, 4799.472058073609, 4772.665913386029, 4775.188218002948, 4778.928316075262, 4778.95221047792, 4825.20384136617, 5173.120569503193, 5174.09453345663, 5185.714785686786, 5222.556082732972, 5247.212918062283, 5278.9208161877605, 5640.971795141039, 5661.405552417019, 5717.942820571782, 5791.942080579182, 5734.082546792535, 5738.856528586777, 5851.619644723122, 5856.355800861902, 5865.472107510302, 5367.087595108802, 5369.731513424314, 5372.301600791872, 5375.462453754593, 5375.5162035417, 5943.70281485924, 5945.554083443759, 5946.524278057745, 5951.0, 5955.37468565803, 5540.473655002768, 5622.522085622686, 5629.774809007676, 5690.857728556819, 5693.202951586781, 5753.626014309057, 5757.107648314518, 5763.279590051244, 5763.654180749085, 5803.100519419497, 5697.344805347355, 5699.458551437607, 5702.48677619008, 5702.6293290935955, 5706.514946229534, 5583.692896890629, 5604.747786349624, 5657.405972372924, 5673.489385955284, 5719.0, 4800.4479484859685, 4844.273358996108, 4880.438749543777, 4900.09348270564, 4900.754962251873, 4071.3689378146437, 4127.587241275848, 4138.772367519755, 4164.312888373445, 4166.1251137261515, 4783.736894470768, 4881.194602890483, 4888.388951381077, 4890.853274401774, 4897.755112244445, 5776.797812076557, 5787.565932555075, 5803.361630220672, 5862.267216597926, 5866.090755932837, 4869.074875773592, 4877.195262781673, 4896.020795840775, 4897.608191344684, 4941.505849415102, 5198.740062996911, 5207.140821764367, 5207.973960130251, 5212.270282160501, 5214.7914083437, 5174.275601415729, 5299.549538289134, 5299.894002119859, 5302.072137376021, 5310.203469479609, 5772.913406298825, 5778.739956702043, 5782.017057100219, 5783.248177736868, 5783.913241301468, 5251.212318152155, 5314.0, 5314.016906872241, 5315.4418786028455, 5318.175682769177, 5653.717314134195, 5658.971705141448, 5659.915101273402, 5664.518515926193, 5667.20659107717, 5828.242328497268, 5837.416258374298, 5844.26946631671, 5891.057430811221, 5895.174675545512, 5491.368492623399, 5623.746931388179, 5626.803061892814, 5632.436756324335, 5636.436356364331, 5575.99632066232, 5596.9440305598055, 5603.579731520071, 5626.971865140648, 5630.324361076697, 5412.566994640498, 5487.039768040657, 5493.945060549343, 5515.641483303572, 5560.610757246954, 5669.603127781016, 5672.319321681424, 5675.120356344608, 5689.089745640677, 5723.627964182481, 5490.121580547093, 5511.200875873056, 5536.612437129363, 5539.695316757456, 5540.889182216252], "value": 5211.7701200789, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.3370960491486, 692.5498426023084, 712.0245263988337, 936.9812603747921, 952.3809523809518, 23248.30255092348, 32537.51193732093, 32895.67104328956, 32994.505082423726, 33129.66870331296, 34725.13187170315, 34945.825270873676, 35068.64931350686, 35083.82458087706, 35152.0, 7115.075040244761, 7263.164736055342, 7265.128184617854, 7283.453740969422, 7288.489805713602, 5365.839024829262, 5512.779488820443, 6937.0, 7084.787456376292, 7091.290870912919, 7236.059312289395, 7316.524425912298, 7319.3046660567425, 7320.084989376328, 7322.890156647654, 7215.530990485628, 7247.0, 7268.781936541912, 7270.818229544251, 7274.1634712008, 6988.126484189476, 7043.154821421411, 7057.647117644097, 7061.082059332254, 7062.152541694978, 31042.689573104206, 31310.84344578285, 31315.217119571964, 31341.37317253665, 31347.84326078378, 2744.135597286848, 2766.045714228608, 2766.7509924106926, 2769.0308392062616, 2770.9445811083665, 23614.173503927454, 23655.7634423657, 23675.526489470285, 23686.881565592234, 23722.288331350086, 3151.8739250429953, 3193.888213912502, 3205.118592387089, 3205.4550726376574, 3257.2508323085585, 129942.0, 130620.34689826585, 130637.0, 130990.0, 131034.0, 38991.41512877309, 39076.41385379222, 39113.21773564513, 39131.804340978684, 39176.80411597981, 41511.792441038204, 41525.0, 41566.79216603898, 41571.376429353586, 41602.1679566407, 10850.945745271381, 10910.181736369805, 10929.180311476672, 10930.234883558074, 10941.671749847517, 8704.347173961978, 8726.607302671395, 8744.169303916118, 8759.430637008574, 8767.649294028295, 8667.739967800977, 8731.781705457415, 8821.558922053871, 10224.591016359262, 11081.778364432666, 4874.95125048745, 4901.374179780217, 4922.0, 4958.801647934114, 4986.501349864984, 878.1481962496368, 882.6601758323092, 893.7363477774072, 902.7833320003152, 909.9226565741853, 18661.90669046673, 19979.700304495444, 19988.90005549963, 20345.186192552133, 23876.64185037226, 929.9395539289925, 951.700928232957, 973.6884197057016, 975.5366201054584, 977.9853302200472, 10080.647177348757, 10623.415712135908, 10625.309354891908, 10633.361998279974, 10732.624358147428, 192625.0, 193460.0, 193835.0, 194157.0, 194271.0, 36340.636593634255, 36683.81658091746, 36700.63299367025, 36720.0, 36760.0, 1197.5030362399507, 1246.3020708403324, 1247.1768632702554, 1247.457356050121, 1247.7566874459574, 17958.281668733627, 17959.47656397947, 18568.81431185671, 18879.90560047191, 19080.618387631894, 27506.587401188597, 27518.44963100767, 27554.448911021267, 27619.171424857286, 27641.0, 181494.09252954178, 181976.0, 182481.0, 182667.0, 182808.0, 25942.0, 26211.475770484863, 26279.897608190917, 26359.0, 26467.7353226473, 23783.167589134297, 24119.0, 31575.21061973469, 31591.035634743585, 32425.0, 23649.462784918924, 24505.75494245106, 24897.128600498894, 25812.612810807477, 25879.611805823304, 24105.638415424135, 24192.395190120387, 25042.37394065163, 25281.11516096928, 25421.364465888502, 26676.59985100186, 26703.46593068089, 26865.731342686322, 27008.0, 27361.45277094407, 24069.0, 24121.276361709177, 24500.142495012587, 24762.380940476633, 25249.242522724348, 19123.61752764909, 20017.399478015683, 20204.494887627927, 20240.392788216377, 20265.898670506554], "value": 13710.238196728138, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [411.7796978616439, 419.12193953667065, 425.91481703659275, 436.9191699535586, 444.7909482543205, 17570.29718811249, 17805.64388712225, 17951.102444877768, 18712.157952892117, 18751.531211719714, 17099.91450042748, 17317.480475585722, 17911.462656120304, 18336.174872130752, 18448.35430759924, 5686.857828554288, 5740.684262365568, 5762.769489220447, 5764.077747560391, 5804.912926306109, 5621.8594535136535, 5772.595918285721, 5798.768049278024, 5804.303483581976, 5806.796762113327, 5437.13005919053, 5599.664020158803, 5643.322801263854, 5645.379008309083, 5773.364929857712, 5519.337679478448, 5659.320881494226, 5683.772649094031, 5694.6867922264255, 5695.117256825178, 5103.336566246364, 5160.92258616121, 5164.147915593922, 5167.121589329823, 5167.689938603696, 22466.213682521033, 22578.548429031493, 22802.543949120925, 22909.541809163722, 23067.423314417105, 1607.5900645335482, 1641.105597449381, 1659.1704147926037, 1663.193351224655, 1664.950051498445, 14286.928565357211, 14501.274936253145, 14807.925960370128, 15009.0, 15106.471273505484, 2025.3923822853085, 2107.9262225822176, 2124.883131427771, 2133.669281261407, 2154.838387120972, 68215.0, 88781.55609221978, 90165.54917225438, 90470.0, 93948.53025734896, 10890.61882834097, 10893.237473376947, 10981.341119532854, 11421.486033128363, 11585.131115166396, 16143.838561614233, 16153.0, 16168.27242774078, 16168.919155404148, 16190.838091618933, 7344.412447004333, 7667.731629392944, 7695.846083078419, 7799.33705635016, 7832.0, 6669.666121161396, 6726.621042686237, 6768.390844823989, 6783.559068660521, 6983.546069505466, 6851.828704282433, 6881.0, 6898.620575868375, 6906.620135892474, 6948.895766563505, 1870.2892900697648, 1923.1249781349452, 1926.5376309685855, 2088.968665470019, 2197.274899283265, 824.7278398128603, 839.5424493650975, 870.9651613935372, 887.3611000079932, 898.6854600889636, 16413.91793041051, 16550.917245413697, 16959.491215263562, 17026.404075857532, 17154.571135721457, 861.1990848510819, 864.8356812205661, 877.8639310906692, 880.6873559886276, 886.5833058462513, 9158.221551168226, 9378.390404623678, 10640.574377024986, 11501.0, 11707.531698731955, 466207.0, 467056.0, 475643.0, 483863.0, 486353.0, 87188.0, 91889.39037316086, 92749.0, 94231.52884235534, 96242.51878740701, 1107.545906178479, 1113.4711012269108, 1133.2010932292715, 1135.4833550734395, 1138.2885696439726, 16510.33958641641, 16748.0, 16996.49010529686, 17290.567735806704, 17632.91183544074, 43885.78057109694, 43953.78023109864, 44314.556854431044, 44337.0, 44468.77765611151, 56789.0, 56986.43013569977, 57077.429225708875, 58136.41863581479, 58354.4164558349, 7316.158641756266, 7492.51298665585, 7527.849443011219, 7670.616469176631, 7956.9602151988865, 11394.772104557696, 11399.772004560029, 11942.940285298519, 12285.447154877873, 12395.070369722487, 10101.69694909154, 10353.534090966075, 10376.377417354983, 10409.583616655249, 10943.124550036136, 9705.223582113273, 9926.801463970825, 9945.403275803475, 10063.899361006297, 10190.031946965322, 10017.799644007226, 10104.848427273744, 10117.696469105644, 10125.493725313852, 10132.0, 7674.117476490275, 7837.804054898673, 7877.724279650185, 7977.641006154621, 8091.878621820795, 10374.325668831501, 10388.272820902464, 10392.740181495523, 10453.216008799523, 10646.20153488507], "value": 8993.448340829646, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1255.8869701726846, 1314.513629956916, 1325.8806707396332, 1332.9066965312427, 1337.4516448256213, 9771.902280977189, 10169.38983660981, 10182.185425165979, 10187.185025197976, 10188.388696678187, 10027.0, 10165.135963443116, 10471.057604815565, 10492.580296788119, 10520.473976301193, 2226.1206823304824, 2253.4704344479032, 2258.762829902861, 2271.3980795089233, 2279.2706333973133, 1841.990790046048, 2054.5685406064745, 2120.141342756186, 2159.1903036361364, 2161.5136594266323, 1827.9543011424687, 2130.6377915754283, 2192.550527141932, 2200.8679479231296, 2208.094681180716, 2169.945751356213, 2191.8465707400487, 2199.6590528468114, 2202.8898555072265, 2203.2398822406244, 2056.506438454775, 2062.3091264426284, 2064.4735592423986, 2064.64900966836, 2066.90698918549, 9771.511424428822, 9933.0, 9962.850557241647, 9964.252681048878, 9964.90035099647, 5278.392984806719, 5453.918191227135, 5468.125099983983, 5470.781168753245, 5471.097268950618, 3151.6848315168527, 3221.1624977505785, 3262.494313381406, 3263.2494526259093, 3279.3769183854993, 979.6816034788723, 1014.2291858187757, 1069.337011053152, 1077.5474300793608, 1079.1205167788228, 14995.250237488082, 15196.46812361573, 15202.771958420633, 15206.391744330214, 15208.16355100469, 4666.113438446684, 4791.6406269529225, 4942.9258561121615, 5003.324551185543, 5047.621428392885, 10413.53139108742, 10416.843747343795, 10435.68692939213, 10449.05958463742, 10454.581816727397, 5314.123169677037, 5330.227117068003, 5336.0, 5341.145416733304, 5346.946530534723, 4830.130576496264, 4877.439094504178, 4895.485973972682, 4896.436909755424, 5026.195808670668, 3818.3317919364, 3874.0629685157423, 3928.253631809947, 4005.539362973237, 4007.0583412897945, 1084.902358787697, 1087.8803331633515, 1089.6513115803025, 1113.1484414422973, 1114.7046032801313, 503.59460634189827, 538.4561592791309, 595.5414330965133, 596.3946594206883, 608.5983251054283, 5451.727413629303, 5554.0835762099605, 5586.832395028075, 5655.264815573949, 5791.82624521265, 500.4670026421849, 505.000099802386, 507.3176577503252, 509.3404041765922, 625.343389441085, 3124.703153200442, 3204.022773054194, 3326.018824446794, 3394.0666316763086, 3433.1931995980926, 12471.563495277622, 12987.155834870704, 13146.342682865818, 13152.868471315356, 13156.276404797636, 12784.552540661218, 13069.346532673328, 13141.54004609834, 13153.0, 13215.207087574585, 9360.719178424659, 9394.06059394055, 9434.858477122849, 9492.288078394009, 9506.762330941781, 5174.223866419917, 5191.792328306826, 5224.843254702365, 5978.790742323998, 6071.150038994632, 11653.0, 11910.940445297718, 11930.642080737593, 11997.64007079789, 12063.577774778192, 11660.708482288012, 11940.76118477643, 12060.0, 12080.275183489019, 12090.75818483643, 7509.0, 7598.924010759822, 7693.961530192313, 7710.92289077102, 7728.7681369559, 8531.658733650833, 8706.390552661507, 8762.824743504967, 8774.692885748967, 8791.604377802887, 7632.1986191451315, 7685.692572297045, 7738.264864837832, 7741.806454838674, 7843.411744119328, 7402.9629851850395, 7513.211112833293, 7539.924600753922, 7540.924590754242, 7600.087989441303, 6737.461003119836, 6761.3238676132, 6769.830754230987, 6808.319168083152, 6866.553674011173, 5090.898182036412, 5143.202803565453, 5179.171332586919, 5199.870003249949, 5236.581073514034, 4970.701757894538, 4992.600591952562, 5088.974555127201, 5191.0, 5205.479452054764], "value": 4546.300321864716, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.1652481066464, 383.7505621346125, 385.7858888316983, 390.85733707196874, 397.3126491170277, 5272.472752724726, 5349.919751203735, 5355.277037599923, 5375.6774593524415, 5381.273528073709, 4971.279164521142, 5213.113770658988, 5236.1098613235745, 5244.505315984945, 5269.473052694729, 4017.2926506234735, 4024.1146947671537, 4025.134596061846, 4032.5564187939303, 4036.0717035081802, 4020.7989600520004, 4025.5974402559655, 4028.858989935353, 4032.899177520556, 4032.9395059074136, 3991.6407523322896, 3999.440078389028, 4001.899952501182, 4005.5994400559857, 4005.939910901339, 3814.370628846237, 3960.1683646434426, 3991.4012898065234, 4005.8998525036814, 4010.455974449829, 3488.372093023255, 3494.9126271843406, 3505.8247087645773, 3509.78941263525, 3513.4905438711244, 5067.417247016603, 5095.923561146586, 5107.3360463139925, 5112.667676601046, 5114.897702045975, 4518.796654150571, 4680.4383473983, 4734.692245004064, 4737.749568954719, 4743.217369134089, 5547.696291371524, 5563.332400111972, 5575.386707462176, 5576.302962129734, 5581.7209139543265, 3937.3503371943593, 3945.5857135000697, 3945.8027098644952, 3953.802309884523, 3954.1103251768122, 5804.8839023219725, 5867.207926929853, 5932.288125424933, 5940.910886336708, 5962.731677074586, 4322.502912165079, 4340.110277393127, 4359.8581347719155, 4366.628836548929, 4372.475302963665, 4411.691181617321, 4424.247877860771, 4427.313766366218, 4433.246348120827, 4436.179306828247, 4745.14587374269, 4901.0, 4909.705417674951, 4915.631327650369, 4933.407991041098, 5608.878224355064, 5629.211910332557, 5639.43605639441, 5648.74580643872, 5652.9152062719095, 1508.3815635589574, 1531.6477210241708, 1531.8851086168581, 1531.9846801532065, 1537.2237020304674, 1015.1422048369117, 1056.8837427882927, 1059.1526778577108, 1066.1151244467073, 1076.520948178069, 4897.118518666674, 4897.1674815281485, 4904.828331008398, 4914.189158788831, 4917.164082106051, 5794.62334948227, 5803.259022293295, 5830.47525722687, 5850.180974663551, 5855.180274761537, 4696.131215725101, 4876.268559716071, 4908.300434760868, 4908.435529914105, 4912.4350699669285, 3047.8628461719277, 3065.7700672449655, 3082.9537556936666, 3085.46004449225, 3089.891853785152, 5311.840644780663, 5329.786808527693, 5341.878205576794, 5348.251244825728, 5357.651752636066, 5650.858728531737, 5762.971185144047, 5913.6936594728095, 5926.940730592725, 5966.134910437962, 5203.635745497854, 5242.239875218072, 5307.734613269321, 5321.122014867504, 5368.355797304349, 5825.446582574648, 5827.329857066492, 5829.883402332014, 5831.562632802472, 5833.67914764692, 5548.528375088163, 5665.546756259571, 5675.687837168995, 5716.828495145152, 5728.312602487728, 5342.171963345688, 5353.4646535346155, 5355.625106242525, 5356.732163391737, 5372.704501252469, 4363.3018717005125, 4363.520012798653, 4368.956310436982, 4371.388005679271, 4372.562743725729, 5602.635828671123, 5791.739371728367, 5817.447342502455, 5820.854478638068, 5835.824925252249, 5599.832005039855, 5600.767831077156, 5615.213870058276, 5628.409017053151, 5649.237352957298, 5491.066518691752, 5610.971945140248, 5641.476801263718, 5649.457744015292, 5666.603337766317, 5557.610967232255, 5566.888662226652, 5571.693556854412, 5575.135853942646, 5578.832635020955, 5684.459976302244, 5685.0, 5689.402612725604, 5699.943000570107, 5702.971485142713, 5334.653247538898, 5519.227308176939, 5531.308586426697, 5533.972330138324, 5545.694986775766], "value": 4256.694709387977, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [647.4270270810331, 662.6719773712014, 678.5453745990186, 700.1842853076166, 700.800271922502, 12164.087693422984, 12738.0, 13271.20372777634, 13272.668183295422, 13280.667983300422, 12669.936650316735, 13000.674983125427, 13000.869991300084, 13018.088733788638, 13018.153820001717, 826.6445428465757, 828.1801016993163, 847.2840449819893, 851.3870013590237, 853.7097386888456, 850.4897061762923, 850.740524140137, 851.7657644147847, 852.5992783391796, 855.7261676263598, 879.3009557401849, 879.4107947675041, 880.2341962492641, 880.7886107334226, 885.2033170146888, 879.2306731609841, 879.4986857491233, 880.4277219807112, 880.520116536486, 885.9867101993475, 642.2678146912524, 646.0212777641876, 647.8866198415259, 649.9902501462482, 652.670401447266, 12865.0, 13115.606531804062, 13134.934325328408, 13219.471221151143, 13247.07270491066, 13397.062205645609, 13853.030287879852, 13924.627346110017, 13934.442622295095, 14029.158250505003, 10372.273940824145, 10794.5682172713, 10879.12966962641, 10883.619073332395, 10946.0, 2767.2805070681566, 2828.6888442271334, 2853.1155341844096, 2878.0, 2879.1794338613395, 60685.39314606842, 60942.76094276098, 61147.0, 62267.37732622661, 63359.6832015837, 10135.594576217016, 10271.702457031703, 10312.123469505175, 10489.370637761758, 10542.209334299958, 19715.901420492806, 20201.191952321744, 20539.691904621443, 20596.0, 20691.58616827655, 6374.171357723466, 6392.296847346788, 6507.804765857032, 6646.96676516624, 6842.452603791685, 3235.1103446551915, 3359.445691460882, 3367.461206206995, 3376.6623337666038, 3415.7438192135687, 3435.158386195398, 3487.9302413952087, 3502.422100353464, 3506.053365591276, 3512.964870351315, 677.7322957431787, 677.8373190434359, 685.2770327304742, 686.9759558415532, 687.4053943338976, 498.7930009046205, 499.29848562769365, 512.6770134815042, 533.842516457646, 536.1341433584732, 7535.434842386733, 7804.960975195201, 8061.717839875693, 8574.485530868167, 9363.0, 536.484974424549, 541.7887024060619, 547.654977364266, 551.4926267833603, 552.4447929830494, 3587.5286410831154, 3854.383298672199, 3884.2425726983533, 3897.2984862724984, 4012.197560487914, 58399.0, 59499.0, 59646.403535964084, 60498.69750651219, 61958.38041619616, 49385.0, 49926.750366247936, 50040.0, 51404.742976285626, 52252.47747522476, 45876.541234587225, 45947.0, 46338.30492542682, 46935.295970560466, 48506.27240591394, 8703.303735701254, 9001.414908031218, 9145.5884485197, 9179.127982841886, 9181.586828592863, 26056.73943260619, 26469.60295595529, 26861.86569067142, 26862.194134176007, 27674.584881226394, 31967.68032319647, 32233.838830805696, 32504.83747581247, 32776.180595485304, 33193.336133276716, 10715.24993250465, 11042.227044106836, 11079.113670906147, 11118.555257789598, 11306.0, 11343.602973895873, 11582.94208528952, 11589.6523104307, 11755.588554400554, 11772.646820595395, 10216.948915255376, 10707.250492465453, 10804.405757683402, 11102.000819926245, 11103.278286911325, 10732.678019659423, 10838.837417438903, 10876.891231087588, 10921.0, 10929.398883061507, 10164.491775411348, 10215.693529194135, 10216.489175541343, 10440.321379110334, 10884.78230435371, 7965.601719914097, 8149.796255093433, 8512.40413171072, 8638.524881131598, 8992.145746154105, 9631.677161190024, 9712.0, 9773.718783228973, 9775.560099795384, 9872.851907221253], "value": 6112.438968219745, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1551.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 112.0, 114.0, 112.0, 112.0, 112.0, 111.0, 112.0, 111.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 130.0, 121.0, 172.0, 126.0, 129.0, 124.0, 123.0, 152.0, 124.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 164.0, 164.0, 165.0, 163.0, 165.0, 168.0, 168.0, 164.0], "value": 164.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 75.0, 116.0, 76.0, 75.0, 75.0, 75.0, 92.0, 76.0], "value": 81.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 122.0, 86.0, 83.0, 84.0, 110.0, 84.0, 84.0, 115.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 113.0, 114.0], "value": 113.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 151.0, 153.0, 150.0, 155.0, 150.0, 151.0, 151.0, 151.0], "value": 151.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 95.0, 98.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 95.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 51.0, 53.0, 53.0, 53.0, 52.0, 54.0, 53.0], "value": 52.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 57.0, 55.0, 55.0, 56.0, 56.0, 56.0, 56.0], "value": 55.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 85.0, 84.0, 86.0, 84.0, 84.0, 86.0, 85.0, 97.0, 85.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 142.0, 145.0, 135.0, 138.0, 140.0, 142.0, 188.0, 140.0], "value": 144.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 197.0, 197.0, 192.0, 194.0, 195.0, 193.0, 195.0, 194.0, 194.0], "value": 193.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [73.0, 71.0, 76.0, 74.0, 73.0, 74.0, 70.0, 72.0, 71.0, 70.0], "value": 72.4, "unit": "score"}]}]} 22:00:50 INFO - Return code: 0 22:00:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:00:50 ERROR - # TBPL SUCCESS # 22:00:50 INFO - Running post-action listener: _resource_record_post_action 22:00:50 INFO - [mozharness: 2017-04-07 05:00:50.751274Z] Finished run-tests step (success) 22:00:50 INFO - Running post-run listener: _resource_record_post_run 22:00:50 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 8192; Write bytes: 360968192; Read time: 20; Write time: 404572 22:00:50 INFO - TinderboxPrint: CPU usage
13.0% 22:00:50 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 22:00:50 INFO - TinderboxPrint: I/O write bytes / time
360,968,192 / 404,572 22:00:50 INFO - TinderboxPrint: CPU idle
8,370.3 (87.0%) 22:00:50 INFO - TinderboxPrint: CPU user
1,204.8 (12.5%) 22:00:50 INFO - TinderboxPrint: Swap in / out
0 / 0 22:00:50 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 103170048; Read time: 0; Write time: 183336 22:00:50 INFO - run-tests - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 257798144; Read time: 12; Write time: 221236 22:00:51 INFO - Running post-run listener: _upload_blobber_files 22:00:51 INFO - Blob upload gear active. 22:00:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:00:51 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 22:00:51 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'] 22:00:51 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 22:00:51 INFO - (blobuploader) - INFO - Open directory for files ... 22:00:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:00:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:00:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:00:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:00:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:00:52 INFO - (blobuploader) - INFO - Done attempting. 22:00:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 22:00:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:00:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:00:53 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 22:00:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:00:53 INFO - (blobuploader) - INFO - Done attempting. 22:00:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:00:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:00:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:00:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:00:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:00:56 INFO - (blobuploader) - INFO - Done attempting. 22:00:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:00:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:00:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:00:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:00:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:00:57 INFO - (blobuploader) - INFO - Done attempting. 22:00:57 INFO - (blobuploader) - INFO - Iteration through files over. 22:00:57 INFO - Return code: 0 22:00:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:00:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:00:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b8778400c1fd9d8d6971ee414f558230346414a912c2aa6f1b25d5a4f5939c45d2fc33301574d2c7f36c3688e879c78f587e9d7bff05daf28512989cd59c800", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90c1906b971a9a6e1b90352ad577bb8d39cee945ff46f2be3646c1036ca57784c6c2f8bc1328eb604226dce455f40965f8f1e5d7f4287aaa57372850f8724980", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1927547110ddfeb1a48fef611f1c6f9fbf46071fc272a741457d16802a1559972f1e9cb5cd42135da33084a9776fa6dbe580aadb76721654d255f9fb79a65f20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b915ca6e83c7c8ae6f523e739cae189189520aa950b306d90c689224e917227a9e9afc5e1f9eba75ce58dd151da2a99ba420d2b00b9d50b56dc1abe1ecc1eb12"} 22:00:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:00:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:00:57 INFO - Contents: 22:00:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b8778400c1fd9d8d6971ee414f558230346414a912c2aa6f1b25d5a4f5939c45d2fc33301574d2c7f36c3688e879c78f587e9d7bff05daf28512989cd59c800", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90c1906b971a9a6e1b90352ad577bb8d39cee945ff46f2be3646c1036ca57784c6c2f8bc1328eb604226dce455f40965f8f1e5d7f4287aaa57372850f8724980", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1927547110ddfeb1a48fef611f1c6f9fbf46071fc272a741457d16802a1559972f1e9cb5cd42135da33084a9776fa6dbe580aadb76721654d255f9fb79a65f20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b915ca6e83c7c8ae6f523e739cae189189520aa950b306d90c689224e917227a9e9afc5e1f9eba75ce58dd151da2a99ba420d2b00b9d50b56dc1abe1ecc1eb12"} 22:00:57 INFO - Running post-run listener: copy_logs_to_upload_dir 22:00:57 INFO - Copying logs to upload dir... 22:00:57 INFO - mkdir: /builds/slave/test/build/upload/logs 22:00:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.190915 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-04-06 22:00:57.413474) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-06 22:00:57.417350) ========= 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=ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b8778400c1fd9d8d6971ee414f558230346414a912c2aa6f1b25d5a4f5939c45d2fc33301574d2c7f36c3688e879c78f587e9d7bff05daf28512989cd59c800", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90c1906b971a9a6e1b90352ad577bb8d39cee945ff46f2be3646c1036ca57784c6c2f8bc1328eb604226dce455f40965f8f1e5d7f4287aaa57372850f8724980", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1927547110ddfeb1a48fef611f1c6f9fbf46071fc272a741457d16802a1559972f1e9cb5cd42135da33084a9776fa6dbe580aadb76721654d255f9fb79a65f20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b915ca6e83c7c8ae6f523e739cae189189520aa950b306d90c689224e917227a9e9afc5e1f9eba75ce58dd151da2a99ba420d2b00b9d50b56dc1abe1ecc1eb12"} build_url:https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011258 build_url: 'https://queue.taskcluster.net/v1/task/ewNiahj9SiyhbBLYmN-paQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7b8778400c1fd9d8d6971ee414f558230346414a912c2aa6f1b25d5a4f5939c45d2fc33301574d2c7f36c3688e879c78f587e9d7bff05daf28512989cd59c800", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/90c1906b971a9a6e1b90352ad577bb8d39cee945ff46f2be3646c1036ca57784c6c2f8bc1328eb604226dce455f40965f8f1e5d7f4287aaa57372850f8724980", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1927547110ddfeb1a48fef611f1c6f9fbf46071fc272a741457d16802a1559972f1e9cb5cd42135da33084a9776fa6dbe580aadb76721654d255f9fb79a65f20", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b915ca6e83c7c8ae6f523e739cae189189520aa950b306d90c689224e917227a9e9afc5e1f9eba75ce58dd151da2a99ba420d2b00b9d50b56dc1abe1ecc1eb12"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-06 22:00:57.444868) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 22:00:57.445208) ========= 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=ba164b0a7b0ec7655860e956000001c1-1491539991.286533-543848729 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004421 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-06 22:00:57.528777) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-06 22:00:57.529108) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-06 22:00:57.529421) ========= ========= Total master_lag: 0.17 =========