builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-036 starttime: 1490197880.96 results: success (0) revision: e03e0c60462c775c7558a1dc9d5cf2076c3cd1f9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 08:51:20.958384) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-22 08:51:20.958996) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 08:51:20.959415) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-22 08:51:20.978572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:51:20.978951) ========= 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=14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-22 08:51:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2017-03-22 08:51:21 (223 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.096231 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:51:21.090386) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:51:21.090717) ========= 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=14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023301 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:51:21.142000) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:51:21.142357) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e03e0c60462c775c7558a1dc9d5cf2076c3cd1f9 --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 e03e0c60462c775c7558a1dc9d5cf2076c3cd1f9 --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=14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-22 08:51:21,321 truncating revision to first 12 chars 2017-03-22 08:51:21,321 Setting DEBUG logging. 2017-03-22 08:51:21,321 attempt 1/10 2017-03-22 08:51:21,321 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e03e0c60462c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-22 08:51:21,668 unpacking tar archive at: mozilla-central-e03e0c60462c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.764486 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 08:51:21.924413) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 08:51:21.924708) ========= script_repo_revision: e03e0c60462c775c7558a1dc9d5cf2076c3cd1f9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-22 08:51:21.925108) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 08:51:21.925378) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-22 08:51:21.947273) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-22 08:51:21.947660) ========= /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=14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:51:22 INFO - MultiFileLogger online at 20170322 08:51:22 in /builds/slave/test 08:51:22 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 08:51:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:51:22 INFO - {'append_to_log': False, 08:51:22 INFO - 'base_work_dir': '/builds/slave/test', 08:51:22 INFO - 'blob_upload_branch': 'Firefox', 08:51:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:51:22 INFO - 'branch': 'Firefox', 08:51:22 INFO - 'buildbot_json_path': 'buildprops.json', 08:51:22 INFO - 'config_files': ('talos/linux_config.py',), 08:51:22 INFO - 'default_actions': ('clobber', 08:51:22 INFO - 'read-buildbot-config', 08:51:22 INFO - 'download-and-extract', 08:51:22 INFO - 'populate-webroot', 08:51:22 INFO - 'create-virtualenv', 08:51:22 INFO - 'install', 08:51:22 INFO - 'run-tests'), 08:51:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:51:22 INFO - 'download_minidump_stackwalk': True, 08:51:22 INFO - 'download_symbols': 'ondemand', 08:51:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:51:22 INFO - 'tooltool.py': '/tools/tooltool.py', 08:51:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:51:22 INFO - '/tools/misc-python/virtualenv.py')}, 08:51:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:51:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:51:22 INFO - 'gecko_profile': False, 08:51:22 INFO - 'gecko_profile_interval': 0, 08:51:22 INFO - 'installer_path': 'installer.exe', 08:51:22 INFO - 'log_level': 'info', 08:51:22 INFO - 'log_name': 'talos', 08:51:22 INFO - 'log_to_console': True, 08:51:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:51:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:51:22 INFO - 'opt_config_files': (), 08:51:22 INFO - 'pip_index': False, 08:51:22 INFO - 'suite': 'dromaeojs', 08:51:22 INFO - 'system_bits': '32', 08:51:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:51:22 INFO - 'title': 'talos-linux64-ix-036', 08:51:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:51:22 INFO - 'use_talos_json': True, 08:51:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:51:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:51:22 INFO - 'work_dir': 'build'} 08:51:22 INFO - [mozharness: 2017-03-22 15:51:22.224764Z] Running clobber step. 08:51:22 INFO - Running pre-action listener: _resource_record_pre_action 08:51:22 INFO - Running main action method: clobber 08:51:22 INFO - rmtree: /builds/slave/test/build 08:51:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:51:23 INFO - Running post-action listener: _resource_record_post_action 08:51:23 INFO - [mozharness: 2017-03-22 15:51:23.295116Z] Finished clobber step (success) 08:51:23 INFO - [mozharness: 2017-03-22 15:51:23.295215Z] Running read-buildbot-config step. 08:51:23 INFO - Running pre-action listener: _resource_record_pre_action 08:51:23 INFO - Running main action method: read_buildbot_config 08:51:23 INFO - Using buildbot properties: 08:51:23 INFO - { 08:51:23 INFO - "project": "", 08:51:23 INFO - "product": "firefox", 08:51:23 INFO - "who": "cbook@mozilla.com", 08:51:23 INFO - "installer_path": "public/build/target.tar.bz2", 08:51:23 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 08:51:23 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:51:23 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 08:51:23 INFO - "stage_platform": "linux64-pgo", 08:51:23 INFO - "basedir": "/builds/slave/test", 08:51:23 INFO - "buildnumber": 88, 08:51:23 INFO - "platform": "ubuntu64_hw", 08:51:23 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:51:23 INFO - "slavebuilddir": "test", 08:51:23 INFO - "taskId": "DOVIVTfIRGKF46QBhX0gKA", 08:51:23 INFO - "branch": "mozilla-central", 08:51:23 INFO - "script_repo_revision": "production", 08:51:23 INFO - "revision": "e03e0c60462c775c7558a1dc9d5cf2076c3cd1f9", 08:51:23 INFO - "slavename": "talos-linux64-ix-036", 08:51:23 INFO - "repo_path": "mozilla-central" 08:51:23 INFO - } 08:51:23 INFO - Finding installer, test and symbols from parent task. 08:51:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DOVIVTfIRGKF46QBhX0gKA'}, attempt #1 08:51:23 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DOVIVTfIRGKF46QBhX0gKA'}, attempt #1 08:51:24 INFO - Task dependencies: cX3r_vUeQnyvTX1YGVjIgA 08:51:24 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cX3r_vUeQnyvTX1YGVjIgA'}, attempt #1 08:51:24 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/cX3r_vUeQnyvTX1YGVjIgA/artifacts/public/build/target.tar.bz2 08:51:24 INFO - Set test_url: https://queue.taskcluster.net/v1/task/cX3r_vUeQnyvTX1YGVjIgA/artifacts/public/build/test_packages.json 08:51:24 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/cX3r_vUeQnyvTX1YGVjIgA/artifacts/public/build/target.crashreporter-symbols.zip 08:51:24 INFO - Running post-action listener: _resource_record_post_action 08:51:24 INFO - [mozharness: 2017-03-22 15:51:24.706097Z] Finished read-buildbot-config step (success) 08:51:24 INFO - [mozharness: 2017-03-22 15:51:24.706314Z] Running download-and-extract step. 08:51:24 INFO - Running pre-action listener: _resource_record_pre_action 08:51:24 INFO - Running main action method: download_and_extract 08:51:24 INFO - mkdir: /builds/slave/test/build/tests 08:51: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')]} 08:51:24 INFO - trying https://queue.taskcluster.net/v1/task/cX3r_vUeQnyvTX1YGVjIgA/artifacts/public/build/target.test_packages.json 08:51:24 INFO - Downloading https://queue.taskcluster.net/v1/task/cX3r_vUeQnyvTX1YGVjIgA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:51:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cX3r_vUeQnyvTX1YGVjIgA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:51:25 INFO - Downloaded 986 bytes. 08:51:25 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:51:25 INFO - Using the following test package requirements: 08:51:25 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 08:51:25 INFO - u'common': [u'target.common.tests.zip'], 08:51:25 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:51:25 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:51:25 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:51:25 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:51:25 INFO - u'mozbase': [u'target.common.tests.zip'], 08:51:25 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:51:25 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:51:25 INFO - u'web-platform': [u'target.common.tests.zip', 08:51:25 INFO - u'target.web-platform.tests.zip'], 08:51:25 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:51:25 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:51:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cX3r_vUeQnyvTX1YGVjIgA/artifacts/public/build/target.common.tests.zip 08:51:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cX3r_vUeQnyvTX1YGVjIgA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:51:25 INFO - Fetch https://queue.taskcluster.net/v1/task/cX3r_vUeQnyvTX1YGVjIgA/artifacts/public/build/target.common.tests.zip into memory 08:51:26 INFO - Expected file size: 60243186 08:51:26 INFO - Obtained file size: 60243186 08:51:36 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:51:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cX3r_vUeQnyvTX1YGVjIgA/artifacts/public/build/target.common.tests.zip 08:51:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cX3r_vUeQnyvTX1YGVjIgA/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:51:36 INFO - Fetch https://queue.taskcluster.net/v1/task/cX3r_vUeQnyvTX1YGVjIgA/artifacts/public/build/target.common.tests.zip into memory 08:51:37 INFO - Expected file size: 60243186 08:51:37 INFO - Obtained file size: 60243186 08:51:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cX3r_vUeQnyvTX1YGVjIgA/artifacts/public/build/target.talos.tests.zip 08:51:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cX3r_vUeQnyvTX1YGVjIgA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:51:48 INFO - Fetch https://queue.taskcluster.net/v1/task/cX3r_vUeQnyvTX1YGVjIgA/artifacts/public/build/target.talos.tests.zip into memory 08:51:48 INFO - Expected file size: 14404171 08:51:48 INFO - Obtained file size: 14404171 08:51:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:49 INFO - trying https://queue.taskcluster.net/v1/task/cX3r_vUeQnyvTX1YGVjIgA/artifacts/public/build/target.tar.bz2 08:51:49 INFO - Downloading https://queue.taskcluster.net/v1/task/cX3r_vUeQnyvTX1YGVjIgA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:51:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cX3r_vUeQnyvTX1YGVjIgA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:51:50 INFO - Downloaded 67192058 bytes. 08:51:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cX3r_vUeQnyvTX1YGVjIgA/artifacts/public/build/target.tar.bz2 08:51:50 INFO - mkdir: /builds/slave/test/properties 08:51:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:51:50 INFO - Writing to file /builds/slave/test/properties/build_url 08:51:50 INFO - Contents: 08:51:50 INFO - build_url:https://queue.taskcluster.net/v1/task/cX3r_vUeQnyvTX1YGVjIgA/artifacts/public/build/target.tar.bz2 08:51:50 INFO - Running post-action listener: _resource_record_post_action 08:51:50 INFO - Running post-action listener: set_extra_try_arguments 08:51:50 INFO - [mozharness: 2017-03-22 15:51:50.339304Z] Finished download-and-extract step (success) 08:51:50 INFO - [mozharness: 2017-03-22 15:51:50.339416Z] Running populate-webroot step. 08:51:50 INFO - Running pre-action listener: _resource_record_pre_action 08:51:50 INFO - Running main action method: populate_webroot 08:51:50 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:51:50 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:51:50 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:51:50 INFO - '--tppagecycles', 08:51:50 INFO - '7'], 08:51:50 INFO - 'tests': ['tsvgm']}}, 08:51:50 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:51:50 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:51:50 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:51:50 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:51:50 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:51:50 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:51:50 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:51:50 INFO - 'talos_options': ['--disable-e10s'], 08:51:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:50 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:51:50 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:51:50 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:51:50 INFO - 'talos_options': ['--disable-e10s'], 08:51:50 INFO - 'tests': ['damp', 'tps']}, 08:51:50 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:51:50 INFO - 'tests': ['damp', 'tps']}, 08:51:50 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:51:50 INFO - 'tests': ['dromaeo_dom']}, 08:51:50 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:51:50 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:51:50 INFO - 'tests': ['basic_compositor_video']}, 08:51:50 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:51:50 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:51:50 INFO - 'tests': ['a11yr', 08:51:50 INFO - 'ts_paint', 08:51:50 INFO - 'tpaint', 08:51:50 INFO - 'sessionrestore', 08:51:50 INFO - 'sessionrestore_no_auto_restore', 08:51:50 INFO - 'tabpaint']}, 08:51:50 INFO - 'other-e10s': {'tests': ['a11yr', 08:51:50 INFO - 'ts_paint', 08:51:50 INFO - 'tpaint', 08:51:50 INFO - 'sessionrestore', 08:51:50 INFO - 'sessionrestore_no_auto_restore', 08:51:50 INFO - 'tabpaint']}, 08:51:50 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:51:50 INFO - 'ts_paint', 08:51:50 INFO - 'tpaint', 08:51:50 INFO - 'sessionrestore', 08:51:50 INFO - 'sessionrestore_no_auto_restore', 08:51:50 INFO - 'tabpaint']}, 08:51:50 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:51:50 INFO - 'ts_paint', 08:51:50 INFO - 'tpaint', 08:51:50 INFO - 'sessionrestore', 08:51:50 INFO - 'sessionrestore_no_auto_restore', 08:51:50 INFO - 'tabpaint']}, 08:51:50 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:51:50 INFO - 'tests': ['a11yr', 08:51:50 INFO - 'ts_paint', 08:51:50 INFO - 'tpaint', 08:51:50 INFO - 'sessionrestore', 08:51:50 INFO - 'sessionrestore_no_auto_restore', 08:51:50 INFO - 'tabpaint']}, 08:51:50 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:51:50 INFO - 'tests': ['a11yr', 08:51:50 INFO - 'ts_paint', 08:51:50 INFO - 'tpaint', 08:51:50 INFO - 'sessionrestore', 08:51:50 INFO - 'sessionrestore_no_auto_restore', 08:51:50 INFO - 'tabpaint']}, 08:51:50 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:51:50 INFO - 'tests': ['tsvgx', 08:51:50 INFO - 'tsvgr_opacity', 08:51:50 INFO - 'tart', 08:51:50 INFO - 'tscrollx', 08:51:50 INFO - 'cart', 08:51:50 INFO - 'tsvg_static']}, 08:51:50 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:51:50 INFO - 'tsvgr_opacity', 08:51:50 INFO - 'tart', 08:51:50 INFO - 'tscrollx', 08:51:50 INFO - 'cart', 08:51:50 INFO - 'tsvg_static']}, 08:51:50 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:51:50 INFO - 'talos_options': ['--disable-e10s'], 08:51:50 INFO - 'tests': ['tp5o']}, 08:51:50 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:51:50 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:51:50 INFO - 'talos_options': ['--disable-e10s', 08:51:50 INFO - '--xperf_path', 08:51:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:51:50 INFO - 'tests': ['tp5n']}, 08:51:50 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:51:50 INFO - 'talos_options': ['--xperf_path', 08:51:50 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:51:50 INFO - 'tests': ['tp5n']}}, 08:51:50 INFO - 'talos.zip': {'path': '', 08:51:50 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:51:50 INFO - Running post-action listener: _resource_record_post_action 08:51:50 INFO - [mozharness: 2017-03-22 15:51:50.354795Z] Finished populate-webroot step (success) 08:51:50 INFO - [mozharness: 2017-03-22 15:51:50.354886Z] Running create-virtualenv step. 08:51:50 INFO - Running pre-action listener: _resource_record_pre_action 08:51:50 INFO - Running main action method: create_virtualenv 08:51:50 INFO - Creating virtualenv /builds/slave/test/build/venv 08:51:50 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:51:50 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:51:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:51:50 INFO - Using real prefix '/usr' 08:51:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:51:50 INFO - Installing distribute.............................................................................................................................................................................................done. 08:51:52 INFO - Installing pip.................done. 08:51:52 INFO - Return code: 0 08:51:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:51:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:51:53 INFO - Reading from file tmpfile_stdout 08:51:53 INFO - Output received: 08:51:53 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 08:51:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:53 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 0xef81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1196310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1193400>, '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 0x11943b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1194840>, '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': '14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:51:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:51:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:51:53 INFO - Using env: {'DISPLAY': ':0', 08:51:53 INFO - 'HOME': '/home/cltbld', 08:51:53 INFO - 'LANG': 'en_US.UTF-8', 08:51:53 INFO - 'LANGUAGE': 'en_US:en', 08:51:53 INFO - 'LOGNAME': 'cltbld', 08:51:53 INFO - 'MAIL': '/var/mail/cltbld', 08:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:53 INFO - 'MOZ_NO_REMOTE': '1', 08:51:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:53 INFO - 'NO_EM_RESTART': '1', 08:51:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:53 INFO - 'PWD': '/builds/slave/test', 08:51:53 INFO - 'SHELL': '/bin/bash', 08:51:53 INFO - 'SHLVL': '1', 08:51:53 INFO - 'TERM': 'linux', 08:51:53 INFO - 'TMOUT': '86400', 08:51:53 INFO - 'USER': 'cltbld', 08:51:53 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825', 08:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:53 INFO - '_': '/tools/buildbot/bin/python'} 08:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:51:53 INFO - Cleaning up... 08:51:53 INFO - Return code: 0 08:51:53 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:53 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 0xef81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1196310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1193400>, '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 0x11943b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1194840>, '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': '14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:51:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:51:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:51:53 INFO - Using env: {'DISPLAY': ':0', 08:51:53 INFO - 'HOME': '/home/cltbld', 08:51:53 INFO - 'LANG': 'en_US.UTF-8', 08:51:53 INFO - 'LANGUAGE': 'en_US:en', 08:51:53 INFO - 'LOGNAME': 'cltbld', 08:51:53 INFO - 'MAIL': '/var/mail/cltbld', 08:51:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:53 INFO - 'MOZ_NO_REMOTE': '1', 08:51:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:53 INFO - 'NO_EM_RESTART': '1', 08:51:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:53 INFO - 'PWD': '/builds/slave/test', 08:51:53 INFO - 'SHELL': '/bin/bash', 08:51:53 INFO - 'SHLVL': '1', 08:51:53 INFO - 'TERM': 'linux', 08:51:53 INFO - 'TMOUT': '86400', 08:51:53 INFO - 'USER': 'cltbld', 08:51:53 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825', 08:51:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:53 INFO - '_': '/tools/buildbot/bin/python'} 08:51:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:53 INFO - Downloading/unpacking psutil>=3.1.1 08:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:51:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:55 INFO - Installing collected packages: psutil 08:51:55 INFO - Running setup.py install for psutil 08:51:55 INFO - building 'psutil._psutil_linux' extension 08:51:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 08:51:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:51:55 INFO - building 'psutil._psutil_posix' extension 08:51:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:51:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:51:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:51:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:51:56 INFO - Successfully installed psutil 08:51:56 INFO - Cleaning up... 08:51:56 INFO - Return code: 0 08:51:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:51: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')]} 08:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51: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')]} 08:51:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:56 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 0xef81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1196310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1193400>, '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 0x11943b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1194840>, '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': '14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:51:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:51:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:51:56 INFO - Using env: {'DISPLAY': ':0', 08:51:56 INFO - 'HOME': '/home/cltbld', 08:51:56 INFO - 'LANG': 'en_US.UTF-8', 08:51:56 INFO - 'LANGUAGE': 'en_US:en', 08:51:56 INFO - 'LOGNAME': 'cltbld', 08:51:56 INFO - 'MAIL': '/var/mail/cltbld', 08:51:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:56 INFO - 'MOZ_NO_REMOTE': '1', 08:51:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:56 INFO - 'NO_EM_RESTART': '1', 08:51:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:56 INFO - 'PWD': '/builds/slave/test', 08:51:56 INFO - 'SHELL': '/bin/bash', 08:51:56 INFO - 'SHLVL': '1', 08:51:56 INFO - 'TERM': 'linux', 08:51:56 INFO - 'TMOUT': '86400', 08:51:56 INFO - 'USER': 'cltbld', 08:51:56 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825', 08:51:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:56 INFO - '_': '/tools/buildbot/bin/python'} 08:51:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:51:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:51:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:51:58 INFO - Installing collected packages: mozsystemmonitor 08:51:58 INFO - Running setup.py install for mozsystemmonitor 08:51:58 INFO - Successfully installed mozsystemmonitor 08:51:58 INFO - Cleaning up... 08:51:58 INFO - Return code: 0 08:51:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:51:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:51:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:51:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:51:58 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 0xef81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1196310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1193400>, '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 0x11943b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1194840>, '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': '14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:51:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:51:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:51:58 INFO - Using env: {'DISPLAY': ':0', 08:51:58 INFO - 'HOME': '/home/cltbld', 08:51:58 INFO - 'LANG': 'en_US.UTF-8', 08:51:58 INFO - 'LANGUAGE': 'en_US:en', 08:51:58 INFO - 'LOGNAME': 'cltbld', 08:51:58 INFO - 'MAIL': '/var/mail/cltbld', 08:51:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:51:58 INFO - 'MOZ_NO_REMOTE': '1', 08:51:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:51:58 INFO - 'NO_EM_RESTART': '1', 08:51:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:51:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:51:58 INFO - 'PWD': '/builds/slave/test', 08:51:58 INFO - 'SHELL': '/bin/bash', 08:51:58 INFO - 'SHLVL': '1', 08:51:58 INFO - 'TERM': 'linux', 08:51:58 INFO - 'TMOUT': '86400', 08:51:58 INFO - 'USER': 'cltbld', 08:51:58 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825', 08:51:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:51:58 INFO - '_': '/tools/buildbot/bin/python'} 08:51:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:51:58 INFO - Downloading/unpacking jsonschema==2.5.1 08:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:51:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:51:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:51:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:52:02 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:02 INFO - Downloading functools32-3.2.3-2.tar.gz 08:52:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:52:03 INFO - warning: no files found matching '*.txt' 08:52:03 INFO - no previously-included directories found matching 'build' 08:52:03 INFO - no previously-included directories found matching 'dist' 08:52:03 INFO - no previously-included directories found matching '.git*' 08:52:03 INFO - Installing collected packages: jsonschema, functools32 08:52:03 INFO - Running setup.py install for functools32 08:52:03 INFO - warning: no files found matching '*.txt' 08:52:03 INFO - no previously-included directories found matching 'build' 08:52:03 INFO - no previously-included directories found matching 'dist' 08:52:03 INFO - no previously-included directories found matching '.git*' 08:52:03 INFO - Successfully installed jsonschema functools32 08:52:03 INFO - Cleaning up... 08:52:03 INFO - Return code: 0 08:52:03 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:04 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 0xef81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1196310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1193400>, '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 0x11943b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1194840>, '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': '14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:52:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:52:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:52:04 INFO - Using env: {'DISPLAY': ':0', 08:52:04 INFO - 'HOME': '/home/cltbld', 08:52:04 INFO - 'LANG': 'en_US.UTF-8', 08:52:04 INFO - 'LANGUAGE': 'en_US:en', 08:52:04 INFO - 'LOGNAME': 'cltbld', 08:52:04 INFO - 'MAIL': '/var/mail/cltbld', 08:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:04 INFO - 'MOZ_NO_REMOTE': '1', 08:52:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:04 INFO - 'NO_EM_RESTART': '1', 08:52:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:04 INFO - 'PWD': '/builds/slave/test', 08:52:04 INFO - 'SHELL': '/bin/bash', 08:52:04 INFO - 'SHLVL': '1', 08:52:04 INFO - 'TERM': 'linux', 08:52:04 INFO - 'TMOUT': '86400', 08:52:04 INFO - 'USER': 'cltbld', 08:52:04 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825', 08:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:04 INFO - '_': '/tools/buildbot/bin/python'} 08:52:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:52:05 INFO - Cleaning up... 08:52:05 INFO - Return code: 0 08:52:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xef81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1196310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1193400>, '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 0x11943b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1194840>, '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': '14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:52:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:52:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:52:06 INFO - Using env: {'DISPLAY': ':0', 08:52:06 INFO - 'HOME': '/home/cltbld', 08:52:06 INFO - 'LANG': 'en_US.UTF-8', 08:52:06 INFO - 'LANGUAGE': 'en_US:en', 08:52:06 INFO - 'LOGNAME': 'cltbld', 08:52:06 INFO - 'MAIL': '/var/mail/cltbld', 08:52:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:06 INFO - 'MOZ_NO_REMOTE': '1', 08:52:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:06 INFO - 'NO_EM_RESTART': '1', 08:52:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:06 INFO - 'PWD': '/builds/slave/test', 08:52:06 INFO - 'SHELL': '/bin/bash', 08:52:06 INFO - 'SHLVL': '1', 08:52:06 INFO - 'TERM': 'linux', 08:52:06 INFO - 'TMOUT': '86400', 08:52:06 INFO - 'USER': 'cltbld', 08:52:06 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825', 08:52:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:06 INFO - '_': '/tools/buildbot/bin/python'} 08:52:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:06 INFO - Downloading/unpacking blobuploader==1.2.4 08:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:10 INFO - Downloading blobuploader-1.2.4.tar.gz 08:52:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:52:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:52:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:11 INFO - Downloading docopt-0.6.1.tar.gz 08:52:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:52:11 INFO - Installing collected packages: blobuploader, requests, docopt 08:52:11 INFO - Running setup.py install for blobuploader 08:52:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:52:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:52:11 INFO - Running setup.py install for requests 08:52:11 INFO - Running setup.py install for docopt 08:52:11 INFO - Successfully installed blobuploader requests docopt 08:52:11 INFO - Cleaning up... 08:52:11 INFO - Return code: 0 08:52:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:11 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 0xef81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1196310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1193400>, '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 0x11943b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1194840>, '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': '14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:52:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:52:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:52:11 INFO - Using env: {'DISPLAY': ':0', 08:52:11 INFO - 'HOME': '/home/cltbld', 08:52:11 INFO - 'LANG': 'en_US.UTF-8', 08:52:11 INFO - 'LANGUAGE': 'en_US:en', 08:52:11 INFO - 'LOGNAME': 'cltbld', 08:52:11 INFO - 'MAIL': '/var/mail/cltbld', 08:52:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:11 INFO - 'MOZ_NO_REMOTE': '1', 08:52:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:11 INFO - 'NO_EM_RESTART': '1', 08:52:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:11 INFO - 'PWD': '/builds/slave/test', 08:52:11 INFO - 'SHELL': '/bin/bash', 08:52:11 INFO - 'SHLVL': '1', 08:52:11 INFO - 'TERM': 'linux', 08:52:11 INFO - 'TMOUT': '86400', 08:52:11 INFO - 'USER': 'cltbld', 08:52:11 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825', 08:52:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:11 INFO - '_': '/tools/buildbot/bin/python'} 08:52:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:52:12 INFO - Running setup.py (path:/tmp/pip-Y4Avq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:52:12 INFO - Running setup.py (path:/tmp/pip-WSwLi9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:52:12 INFO - Running setup.py (path:/tmp/pip-BeaUN_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:52:12 INFO - Running setup.py (path:/tmp/pip-jMThBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:52:12 INFO - Running setup.py (path:/tmp/pip-s1glSQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:52:12 INFO - Running setup.py (path:/tmp/pip-cKzzO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:52:12 INFO - Running setup.py (path:/tmp/pip-t02e4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:52:12 INFO - Running setup.py (path:/tmp/pip-RckbVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:52:12 INFO - Running setup.py (path:/tmp/pip-ILvCyV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:52:12 INFO - Running setup.py (path:/tmp/pip-Eiuw2e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:52:12 INFO - Running setup.py (path:/tmp/pip-qw_5_R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:52:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:52:12 INFO - Running setup.py (path:/tmp/pip-zVOi1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:52:13 INFO - Running setup.py (path:/tmp/pip-nIdKbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:52:13 INFO - Running setup.py (path:/tmp/pip-EI8wjm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:13 INFO - Running setup.py (path:/tmp/pip-Wbr8Dh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:52:13 INFO - Running setup.py (path:/tmp/pip-8O0b6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:52:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:52:13 INFO - Running setup.py (path:/tmp/pip-0j3mge-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:52:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:52:13 INFO - Running setup.py install for manifestparser 08:52:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:52:13 INFO - Running setup.py install for mozcrash 08:52:13 INFO - Running setup.py install for mozdebug 08:52:13 INFO - Running setup.py install for mozdevice 08:52:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:52:13 INFO - Running setup.py install for mozfile 08:52:13 INFO - Running setup.py install for mozhttpd 08:52:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:52:13 INFO - Running setup.py install for mozinfo 08:52:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:52:14 INFO - Running setup.py install for mozInstall 08:52:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:52:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:52:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:52:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:52:14 INFO - Running setup.py install for mozleak 08:52:14 INFO - Running setup.py install for mozlog 08:52:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:52:14 INFO - Running setup.py install for moznetwork 08:52:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:52:14 INFO - Running setup.py install for mozprocess 08:52:14 INFO - Running setup.py install for mozprofile 08:52:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:52:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:52:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:52:14 INFO - Running setup.py install for mozrunner 08:52:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:52:14 INFO - Running setup.py install for mozscreenshot 08:52:14 INFO - Running setup.py install for moztest 08:52:15 INFO - Running setup.py install for mozversion 08:52:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:52:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:52:15 INFO - Cleaning up... 08:52:15 INFO - Return code: 0 08:52:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:15 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 0xef81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1196310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1193400>, '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 0x11943b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1194840>, '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': '14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:52:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:52:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:52:15 INFO - Using env: {'DISPLAY': ':0', 08:52:15 INFO - 'HOME': '/home/cltbld', 08:52:15 INFO - 'LANG': 'en_US.UTF-8', 08:52:15 INFO - 'LANGUAGE': 'en_US:en', 08:52:15 INFO - 'LOGNAME': 'cltbld', 08:52:15 INFO - 'MAIL': '/var/mail/cltbld', 08:52:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:15 INFO - 'MOZ_NO_REMOTE': '1', 08:52:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:15 INFO - 'NO_EM_RESTART': '1', 08:52:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:15 INFO - 'PWD': '/builds/slave/test', 08:52:15 INFO - 'SHELL': '/bin/bash', 08:52:15 INFO - 'SHLVL': '1', 08:52:15 INFO - 'TERM': 'linux', 08:52:15 INFO - 'TMOUT': '86400', 08:52:15 INFO - 'USER': 'cltbld', 08:52:15 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825', 08:52:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:15 INFO - '_': '/tools/buildbot/bin/python'} 08:52:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:52:15 INFO - Running setup.py (path:/tmp/pip-3TokmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:52:15 INFO - Running setup.py (path:/tmp/pip-d3FUK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:52:15 INFO - Running setup.py (path:/tmp/pip-iSWmrI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:52:15 INFO - Running setup.py (path:/tmp/pip-axGqEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:52:15 INFO - Running setup.py (path:/tmp/pip-ql42q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:52:15 INFO - Running setup.py (path:/tmp/pip-pXhnTj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 08:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:52:15 INFO - Running setup.py (path:/tmp/pip-YUC5Jb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 08:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:52:15 INFO - Running setup.py (path:/tmp/pip-oRGXlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:52:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:52:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:52:15 INFO - Running setup.py (path:/tmp/pip-kIGg2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:52:16 INFO - Running setup.py (path:/tmp/pip-ctXGLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:52:16 INFO - Running setup.py (path:/tmp/pip-0gC_gF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:52:16 INFO - Running setup.py (path:/tmp/pip-CWAOce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:52:16 INFO - Running setup.py (path:/tmp/pip-b5kGDp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:52:16 INFO - Running setup.py (path:/tmp/pip-rov_Ha-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:16 INFO - Running setup.py (path:/tmp/pip-_s8nOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:52:16 INFO - Running setup.py (path:/tmp/pip-s8QBRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:52:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:52:16 INFO - Running setup.py (path:/tmp/pip-GytaVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:52:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:52:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:52:18 INFO - Downloading blessings-1.6.tar.gz 08:52:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:52:18 INFO - Installing collected packages: blessings 08:52:18 INFO - Running setup.py install for blessings 08:52:18 INFO - Successfully installed blessings 08:52:18 INFO - Cleaning up... 08:52:18 INFO - Return code: 0 08:52:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:52:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:52:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:52:19 INFO - Reading from file tmpfile_stdout 08:52:19 INFO - Current package versions: 08:52:19 INFO - argparse == 1.2.1 08:52:19 INFO - blessings == 1.6 08:52:19 INFO - blobuploader == 1.2.4 08:52:19 INFO - docopt == 0.6.1 08:52:19 INFO - functools32 == 3.2.3-2 08:52:19 INFO - jsonschema == 2.5.1 08:52:19 INFO - manifestparser == 1.1 08:52:19 INFO - mozInstall == 1.12 08:52:19 INFO - mozcrash == 1.0 08:52:19 INFO - mozdebug == 0.1 08:52:19 INFO - mozdevice == 0.49 08:52:19 INFO - mozfile == 1.2 08:52:19 INFO - mozhttpd == 0.7 08:52:19 INFO - mozinfo == 0.9 08:52:19 INFO - mozleak == 0.1 08:52:19 INFO - mozlog == 3.4 08:52:19 INFO - moznetwork == 0.27 08:52:19 INFO - mozprocess == 0.25 08:52:19 INFO - mozprofile == 0.28 08:52:19 INFO - mozrunner == 6.13 08:52:19 INFO - mozscreenshot == 0.1 08:52:19 INFO - mozsystemmonitor == 0.3 08:52:19 INFO - moztest == 0.8 08:52:19 INFO - mozversion == 1.4 08:52:19 INFO - psutil == 3.1.1 08:52:19 INFO - requests == 1.2.3 08:52:19 INFO - wsgiref == 0.1.2 08:52:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:19 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 0xef81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1196310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1193400>, '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 0x11943b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1194840>, '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': '14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:52:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:52:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:52:19 INFO - Using env: {'DISPLAY': ':0', 08:52:19 INFO - 'HOME': '/home/cltbld', 08:52:19 INFO - 'LANG': 'en_US.UTF-8', 08:52:19 INFO - 'LANGUAGE': 'en_US:en', 08:52:19 INFO - 'LOGNAME': 'cltbld', 08:52:19 INFO - 'MAIL': '/var/mail/cltbld', 08:52:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:19 INFO - 'MOZ_NO_REMOTE': '1', 08:52:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:19 INFO - 'NO_EM_RESTART': '1', 08:52:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:19 INFO - 'PWD': '/builds/slave/test', 08:52:19 INFO - 'SHELL': '/bin/bash', 08:52:19 INFO - 'SHLVL': '1', 08:52:19 INFO - 'TERM': 'linux', 08:52:19 INFO - 'TMOUT': '86400', 08:52:19 INFO - 'USER': 'cltbld', 08:52:19 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825', 08:52:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:19 INFO - '_': '/tools/buildbot/bin/python'} 08:52:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:52:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:52:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:52:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:52:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:52:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:52:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:52:19 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:52:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:52:19 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:52:19 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:52:19 INFO - Cleaning up... 08:52:19 INFO - Return code: 0 08:52:19 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:52:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:52:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:52:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:52:19 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 0xef81f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf35a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1196310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1193400>, '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 0x11943b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1194840>, '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': '14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 08:52:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:52:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:52:19 INFO - Using env: {'DISPLAY': ':0', 08:52:19 INFO - 'HOME': '/home/cltbld', 08:52:19 INFO - 'LANG': 'en_US.UTF-8', 08:52:19 INFO - 'LANGUAGE': 'en_US:en', 08:52:19 INFO - 'LOGNAME': 'cltbld', 08:52:19 INFO - 'MAIL': '/var/mail/cltbld', 08:52:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:19 INFO - 'MOZ_NO_REMOTE': '1', 08:52:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:19 INFO - 'NO_EM_RESTART': '1', 08:52:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:19 INFO - 'PWD': '/builds/slave/test', 08:52:19 INFO - 'SHELL': '/bin/bash', 08:52:19 INFO - 'SHLVL': '1', 08:52:19 INFO - 'TERM': 'linux', 08:52:19 INFO - 'TMOUT': '86400', 08:52:19 INFO - 'USER': 'cltbld', 08:52:19 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825', 08:52:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:19 INFO - '_': '/tools/buildbot/bin/python'} 08:52:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:52:19 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:52:19 INFO - Cleaning up... 08:52:19 INFO - Return code: 0 08:52:19 INFO - Running post-action listener: _resource_record_post_action 08:52:19 INFO - Running post-action listener: _start_resource_monitoring 08:52:19 INFO - Starting resource monitoring. 08:52:19 INFO - [mozharness: 2017-03-22 15:52:19.588950Z] Finished create-virtualenv step (success) 08:52:19 INFO - [mozharness: 2017-03-22 15:52:19.589524Z] Running install step. 08:52:19 INFO - Running pre-action listener: _resource_record_pre_action 08:52:19 INFO - Running main action method: install 08:52:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:52:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:52:19 INFO - Reading from file tmpfile_stdout 08:52:19 INFO - Detecting whether we're running mozinstall >=1.0... 08:52:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:52:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:52:19 INFO - Reading from file tmpfile_stdout 08:52:19 INFO - Output received: 08:52:19 INFO - Usage: mozinstall [options] installer 08:52:19 INFO - Options: 08:52:19 INFO - -h, --help show this help message and exit 08:52:19 INFO - -d DEST, --destination=DEST 08:52:19 INFO - Directory to install application into. [default: 08:52:19 INFO - "/builds/slave/test"] 08:52:19 INFO - --app=APP Application being installed. [default: firefox] 08:52:19 INFO - mkdir: /builds/slave/test/build/application 08:52:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:52:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:52:36 INFO - Reading from file tmpfile_stdout 08:52:36 INFO - Output received: 08:52:36 INFO - /builds/slave/test/build/application/firefox/firefox 08:52:36 INFO - Running post-action listener: _resource_record_post_action 08:52:36 INFO - [mozharness: 2017-03-22 15:52:36.591581Z] Finished install step (success) 08:52:36 INFO - [mozharness: 2017-03-22 15:52:36.591855Z] Running run-tests step. 08:52:36 INFO - Running pre-action listener: _resource_record_pre_action 08:52:36 INFO - Running main action method: run_tests 08:52:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:52:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:52:36 INFO - Python 2.7.3 08:52:36 INFO - Return code: 0 08:52:36 INFO - grabbing minidump binary from tooltool 08:52: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')]} 08:52:36 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 0x1193400>, '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 0x11943b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1194840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:52:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:52:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:52:36 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:52:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:52:36 INFO - Return code: 0 08:52:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:52:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:52:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:52:36 INFO - ENV: RUST_BACKTRACE is now 1 08:52:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:52:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:52:36 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/cX3r_vUeQnyvTX1YGVjIgA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 08:52:36 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/cX3r_vUeQnyvTX1YGVjIgA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-036 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 08:52:36 INFO - Using env: {'DISPLAY': ':0', 08:52:36 INFO - 'HOME': '/home/cltbld', 08:52:36 INFO - 'LANG': 'en_US.UTF-8', 08:52:36 INFO - 'LANGUAGE': 'en_US:en', 08:52:36 INFO - 'LOGNAME': 'cltbld', 08:52:36 INFO - 'MAIL': '/var/mail/cltbld', 08:52:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:52:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:52:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:52:36 INFO - 'MOZ_NO_REMOTE': '1', 08:52:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:52:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:52:36 INFO - 'NO_EM_RESTART': '1', 08:52:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:52:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:52:36 INFO - 'PWD': '/builds/slave/test', 08:52:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:52:36 INFO - 'RUST_BACKTRACE': '1', 08:52:36 INFO - 'SHELL': '/bin/bash', 08:52:36 INFO - 'SHLVL': '1', 08:52:36 INFO - 'TERM': 'linux', 08:52:36 INFO - 'TMOUT': '86400', 08:52:36 INFO - 'USER': 'cltbld', 08:52:36 INFO - 'XDG_SESSION_COOKIE': '14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825', 08:52:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:52:36 INFO - '_': '/tools/buildbot/bin/python'} 08:52:36 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/cX3r_vUeQnyvTX1YGVjIgA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-036', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 08:52:36 INFO - mozversion application_buildid: 20170322145832 08:52:36 INFO - mozversion application_changeset: e03e0c60462c775c7558a1dc9d5cf2076c3cd1f9 08:52:36 INFO - mozversion application_display_name: Nightly 08:52:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:52:36 INFO - mozversion application_name: Firefox 08:52:36 INFO - mozversion application_remotingname: firefox 08:52:36 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:52:36 INFO - mozversion application_vendor: Mozilla 08:52:36 INFO - mozversion application_version: 55.0a1 08:52:36 INFO - mozversion platform_buildid: 20170322145832 08:52:36 INFO - mozversion platform_changeset: e03e0c60462c775c7558a1dc9d5cf2076c3cd1f9 08:52:36 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:52:36 INFO - mozversion platform_version: 55.0a1 08:52:36 INFO - using testdate: 1490197956 08:52:36 INFO - actual date: 1490197956 08:52:36 INFO - starting webserver on 'localhost:34260' 08:52:36 INFO - SUITE-START | Running 2 tests 08:52:36 INFO - TEST-START | dromaeo_css 08:52:36 INFO - operating with platform_type : linux_ 08:52:36 INFO - Initialising browser for dromaeo_css test... 08:52:36 INFO - TEST-INFO | started process 17706 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU8jEw7/profile http://localhost:34260/getInfo.html) 08:52:40 INFO - PID 17706 | __metrics Screen width/height:1600/1200 08:52:40 INFO - PID 17706 | colorDepth:24 08:52:40 INFO - PID 17706 | Browser inner width/height: 1024/697 08:52:40 INFO - PID 17706 | __metrics 08:52:41 INFO - PID 17706 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:52:41 INFO - PID 17706 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:52:42 INFO - TEST-INFO | 17706: exit 0 08:52:42 INFO - Browser initialized. 08:52:42 INFO - Running cycle 1/1 for dromaeo_css test... 08:52:42 INFO - TEST-INFO | started process 17806 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU8jEw7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:52:54 INFO - PID 17806 | RSS: Main: 145346560 08:52:54 INFO - PID 17806 | 08:55:56 INFO - PID 17806 | Cycle 1(1): loaded http://localhost:34260/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34260/tests/dromaeo/cssquery-ext.html) 08:55:58 INFO - PID 17806 | RSS: Main: 262062080 08:55:58 INFO - PID 17806 | 08:57:44 INFO - PID 17806 | ************************* 08:57:44 INFO - PID 17806 | A coding exception was thrown and uncaught in a Task. 08:57:44 INFO - PID 17806 | 08:57:44 ERROR - PID 17806 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:57:44 INFO - PID 17806 | Full stack: 08:57:44 INFO - PID 17806 | ************************* 08:59:00 INFO - PID 17806 | Cycle 1(1): loaded http://localhost:34260/tests/dromaeo/cssquery-ext.html (next: http://localhost:34260/tests/dromaeo/cssquery-jquery.html) 08:59:01 INFO - PID 17806 | RSS: Main: 235708416 08:59:01 INFO - PID 17806 | 09:02:03 INFO - PID 17806 | Cycle 1(1): loaded http://localhost:34260/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34260/tests/dromaeo/cssquery-mootools.html) 09:02:03 INFO - PID 17806 | RSS: Main: 210305024 09:02:03 INFO - PID 17806 | 09:05:05 INFO - PID 17806 | Cycle 1(1): loaded http://localhost:34260/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34260/tests/dromaeo/cssquery-prototype.html) 09:05:06 INFO - PID 17806 | RSS: Main: 175591424 09:05:06 INFO - PID 17806 | 09:08:08 INFO - PID 17806 | Cycle 1(1): loaded http://localhost:34260/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34260/tests/dromaeo/cssquery-yui.html) 09:08:09 INFO - PID 17806 | RSS: Main: 184856576 09:08:09 INFO - PID 17806 | 09:11:12 INFO - PID 17806 | Cycle 1(1): loaded http://localhost:34260/tests/dromaeo/cssquery-yui.html (next: http://localhost:34260/tests/dromaeo/cssquery-dojo.html) 09:11:12 INFO - PID 17806 | RSS: Main: 251899904 09:11:12 INFO - PID 17806 | 09:11:12 INFO - PID 17806 | __start_tp_report 09:11:12 INFO - PID 17806 | _x_x_mozilla_page_load 09:11:12 INFO - PID 17806 | _x_x_mozilla_page_load_details 09:11:12 INFO - PID 17806 | |i|pagename|runs| 09:11:12 INFO - PID 17806 | |0;dojo.html;3245.4320493913565;3255.983720081402;3266.591676040495;3303.752218583607;3331.466965285553;5721.656700597967;5752.28096487939;5765.481106700396;5769.855753606157;5781.277340332458;5657.801976930808;5704.857378565538;5719.914201286984;5753.798617048405;5765.6540607563575;4942.135126352892;5080.644354895159;5157.226416037587;5161.690298582078;5197.116490196657;5213.504717051874;5262.842114736564;5273.86815329616;5287.180487024498;5300.443453437391;5060.797568097271;5065.848024559269;5133.204353325241;5137.460566640524;5183.041137389576;5133.563647090002;5150.227465880111;5174.663646862942;5224.529792318672;5249.895002099936;5094.770735316883;5135.589152867799;5155.355580552431;5173.275741396207;5187.844364669028;5631;5653.067243904751;5661.716914154317;5751.194832723422;5757.798477053283;6118.43644382056;6147.661878596676;6214.036824292242;6215.844603884894;6222.12890195373;6294.150289710876;6295.276043254993;6300.369963003663;6305.621662700252;6312.747490100391;5712.057510510719;5811.88376232473;5816;5832.096025116114;5878.470937615592;6241.251049873953;6322.4942004639515;6349;6402.327755585689;6407.519436042222;6057.3336932937345;6057.7879774207695;6060.606060606046;6110.205673262448;6119.816405507842;6101.420365065312;6108.5418593605655;6157.353477884758;6158.753649854045;6169.56813023084;6111.694415279218;6122.621817257929;6142.04798256271;6146.078088286793;6147.569670123138;6154.169187159676;6196.845078872974;6199.287081985539;6211.9068213976825;6216.937830621636;4735.455422626374;4738.763061846894;4740.146773580788;4768.380110585602;4781.569658730661;4185.686073544435;4207.642350400189;4215.515215750228;4217.662586993033;4239;5775.364709881909;5811.070228763462;5864.794732184353;5868.501177399969;5874.50066744323;6134.723937422827;6186.505079593621;6193.38066193377;6202.751889924352;6220;5793.652380857162;5794.942050579524;5795.362510123883;5795.768169273266;5807.564432667482;5215.843524694265;5216.739163041909;5245.816396426107;5264.868378290574;5282.4717528246865;6437.130987316652;6451.483881289486;6456.418922296922;6458.903116453163;6472.029195620695;6139.829471381233;6161.84595385119;6162.784302549389;6261.906071408841;6267.749290028531;6323.873522529616;6328.46208072319;6332.11350410952;6393.1369265148605;6399.008153736178;6020.759169633341;6064.090386442069;6184.536159787944;6190.783322583688;6195.907061393992;6105.186826067751;6110.923300256584;6141.240538582456;6155.538334624832;6157.599756015845;6019.608725432833;6033.185519954925;6033.5173186145885;6036.7283472244735;6074.969625151846;5997.730102145327;6014.0678194879865;6018.9398106020135;6027.30685971119;6039.305479869696;5994.250718660168;6070.908936366046;6095.408112664776;6099.746340301087;6119.2350956130485;6037.516998640011;6040.969795151172;6044.546659000504;6047.727852246748;6067.726952287246;5789.681567513827;5791.044477661138;5844.240248767633;5848.239728835224;5882.470577648032 09:11:12 INFO - PID 17806 | |1;ext.html;646.7510008646669;700.439648281375;718.1848601836915;1098.2586753941089;1118.0720002398011;29851.402971940548;35836.82081589592;36685.76342021856;36702;36853.81573092138;42845;43375.56624433755;43407.56592434075;43429.82850857452;43493.34759978603;5899.262592175978;8139.959300203505;8300.958495207546;8309.376796740238;8314.127016663255;6051.485623721989;7477.513961592506;7492.100947886262;7514.323710866049;7568.583727894964;7578.242175782433;7609.4292928030345;7615.543067415945;7616;7627.389808815309;5788.305403351625;7535.660895259699;7583.582902940336;7585.1656317805;7604.923950760504;5937.970310148465;7619.352355049828;7808.102068262109;7810.453268271223;7821.882671759929;36639.267214655825;36828.263434731154;36907.261854763026;36967.630323696685;37232.44151337705;2951.38021015587;2998.295400580862;3021.7129372709555;3028.424599326121;3059.4187104450084;25990;26223.73776262251;28021.57967630487;28876.42247155045;29404.411911761646;3604.2250916052913;3606.0804494853905;3625.8368373422995;3635.7273204509765;3697.944530832013;213655;213659;214608;214747;214825;50323.24515132276;50362.74818625957;50478;50552;50676.74661626668;52459;52466;52604.736976314874;52629.7368513155;52724.47275527272;14346.856531434762;14355.210463424612;14414.351354188877;14477.710445791236;14486.203258820655;9864.852027219598;10010.299279050396;11531.596394126165;11554.364509952033;11593.072554195644;11428.142889283337;11532.654020379403;12326.938365308117;12520.937395312965;12607.810882836764;5107.591392688576;5265.210218467184;5305.469453054664;5370.838874833761;5388.353397592314;1035.6777582491711;1040.6877936618985;1044.7127040064042;1045.1951996962448;1089.5260561655705;25388.746112539007;25421.364465888502;25854.224373268833;25855.224343269732;25917.74082259191;1135.28477059452;1143.9027682647068;1144.2619510415734;1172.407933993328;1187.3647598534742;13053.216806991612;13135.474581016844;13318.866811331956;13404.396802143732;13463.730725385438;289509;290975;292296;292462;292530;54260.45739542633;54340.45659543354;54394;54490.18264726032;54563.45436545663;1416.6033510617044;1447.232966527742;1449.1232804153547;1472.6539263273123;1496.8428315026983;23613.409664758517;23671.289861304187;24893.377665558506;25331.493370132124;25335.493290133727;38836.223275534896;38860.41709374418;38927.80536097415;38972.80513597414;39007.80496097615;299409;300890;301385;301406;301813;31139.53290700596;31648.5252721214;31813.363732724752;31830.84084579562;33572.66427335695;34155.65844341624;39441.60558394379;39618.80190599029;40549.39175912423;43160.568394315655;35394.64605353914;36559.45160822537;36668.26663466769;36926.815365923;38168.236635266585;35924.91689369871;36653.450198246515;36865;36997.6300237005;38119;35812;36258.00580968072;36712.265754684224;36805.44791828071;37876.242475150895;28764.856175719826;30616.540751888293;30898.38203235878;31454;31549.684503154676;26167.345816354744;26214;26221.373098776465;26281.21156365312;26576.468470630094 09:11:12 INFO - PID 17806 | |2;jquery.html;421.2270483662479;435.3448060668694;441.2212445034515;444.5021575835065;464.57027249793936;19019.524511887208;20270.59458810823;20909;21070.89464552679;21097.367078987634;19372.418827435165;21507.354779356607;21618.459538511546;21649.783502164973;21699.783002169974;5940.613860099091;6186.597871138361;6196.194494715681;6198.969005154991;6204.937950620504;5965.4929331006915;6093.78671746489;6121.173641558399;6132.601380910249;6133.080037994292;6092.969535152318;6106.145139680449;6110.511159107283;6110.786122485714;6113.419225173601;5872.0898260769645;6101.847453813668;6136.386361363872;6148.600340977822;6149.661768602725;5494.972525137388;5505.944940550583;5538.889222215533;5548.77804887804;5552.611317207797;25319.36701582475;25331.873340633178;25594;25669.486610267875;25703.871480642665;2082.1983536338466;2090.675945228492;2091.309867743656;2092.529180934293;2137.2840098567;15158.848411515854;15997.440089596808;16162.191890405433;16498.505044848553;16668.33326666932;1862.1992543206416;1869.5886904880904;1874.5594785225462;1886.2455017992775;1887.7257850950552;91262.5436872818;91683;92030;92570.53714731384;93732.53133734356;12033.39833008346;12141.817872731915;12151.878481215252;12303.384830758427;12487;17633.677474189488;17645.911770441067;17667.084930986242;17679.381221657437;17683.469495914887;8424.115467875907;8585.957070214608;8642.524661143698;8696.086910874394;8741.431806932529;7716.382689384835;7746.690132394641;7927.841443171104;8001.439899207;8020.598970051474;7506.887396689054;7601.353884919733;7767.805804854924;7776.5334079954255;7837.451378403457;2192.471286694759;2267.7958983691547;2279.404416908171;2281.6349384098467;2341.988290058573;1020.5203554329453;1024.416082832793;1024.6721049264313;1036.8335622424772;1041.796849614333;19952;20140.496487587636;20169.59660806805;20234.494137646383;20602;1041.6770801051546;1046.1630695443614;1054.5570860238718;1070.6306324318098;1073.4203530093819;10167.186625069977;11077.119948813366;11152.776944461066;11156.274842135235;11206.719832004102;572249;572840;574231;575756;613178;60618.08679934797;64798;93989;103855;105630.47184764026;1076.784643071389;1158.2876530933415;1227.355638289887;1229.661842993184;1237.3503910447087;19980.100895459447;20284.188632454538;20539.897300513403;20906;20942.68585971181;48147.5185248143;48165.27752083651;49021;49050.26424603562;49502.75248623734;63574.68212658907;63764.362356375845;64524.67737661282;64911.35088649242;66145.66927165333;9037.367384283038;9042.954785226295;9271.721848344561;9297.72106836796;9682.612695492102;14216.289185540889;14417;14526.782098268746;14620.195889226196;14672.706545869236;11860.703482413008;11995.760084798081;12010.939945300217;12420.130590858553;12942.158759680591;12096.45565949552;12245.877541224474;12312.199707019374;12478;12607;11301;12063;12478.18891772032;12671.80992285135;12991;9449.196818270524;9546.761330966781;9595.616175352907;9713;9805.852912206465;12609.65950133275;12793.488260469849;12840.229586224856;12848.486060557472;12887.677808054874 09:11:12 INFO - PID 17806 | |3;mootools.html;1288.8388951381078;1345.9932700336503;1365.5493687083263;1366.3851266929885;1366.5558693424634;10306.845397319037;10694.946525267382;10703.036726694596;10706.41114738689;10711.892881071188;10550.683479495608;10877.129829613632;10907.509162087705;10913.23607347486;10917.454127293624;2388.6297623868286;2451.9019239230497;2457.2751038443703;2458.963115553268;2461.876906154694;2050.2209160519055;2125.8724476531456;2342.672025916373;2411.8794060297005;2415.130553000918;2365.266767302142;2427.1262345555588;2431.2706188143575;2434.732179460258;2434.7808697217247;2386.95226095478;2405.579023670851;2414.5895197816412;2415.130553000918;2439.292605144506;2312.5028118954338;2333.0667732906804;2402.5435167318155;2412.6139817629096;2415.3961509622595;11023.724406889813;11063.446827658665;11106.222564420494;11132.666020019413;11169.497372618252;6025.367336429699;6135.509159267248;6147.200863887666;6160.1991741073825;6210.5963112398;3812.2566099610585;3812.752171108869;3924.1955399143108;3947.46709194258;3978.8607398740905;1311.3246677960763;1314.6581888709004;1317.9209247445183;1349.6760777413351;1376.600785772125;15550.300236489385;15571.454999074978;15749.685006299924;15917.602059948595;15937.681246375123;5092.2361645753435;5282.366116066097;5285.154375299933;5305.840824775263;5386.5152136307925;11780.057595392347;11800.350980695972;11805.409729513662;11809.409529523662;11811.291322520676;6067.089936509471;6195.132681424604;6205.6586887721605;6214.285357183981;6219.346968568326;5628.662280263197;5692.971535142297;5706.144078388275;5770.163326317745;5889.440503152194;4191.350340697197;4288.4210631564965;4308.655307575386;4363.149185908781;4377.146456440963;1112.777444511101;1147.7245461089447;1215.6292330839003;1226.1171956191529;1267.7971524556026;768.74247127213;773.083895583735;776.6970881356276;800.7877912353231;814.8085199978001;5993.460588547052;6059.333473317932;6198.535109866688;6268.561200715997;6417.871642567123;921.7004473546124;931.1759093202564;935.4100362943083;943.1228957069991;973.1096047116808;3654.1595433050547;3682.705383569308;3696.963030369716;3727.440883867387;3852.24881148179;14178.929105354613;14601.634959126106;14633.926830365994;14635.195064271355;14649.12105273687;13532.120412173374;13869.167849929037;14025.298735063207;14538;14549.272536373139;9633.421994680202;9778.804423911482;9894.752631184278;9918.652847150315;10187.994541610242;6251.937480625135;6423.357664233727;6464.709088090953;6558.311377305315;6757.087793147862;12041.277523348626;12231.571894983634;12408;12721.80917286223;12806.103572750191;12457.501699931901;12795.93602031984;12908.935455322664;13248.072634915463;13387.330633468093;9090.090990900857;9126.726198214064;9223.44659320443;9234.722958311262;9238.630454781733;10397.584096636352;10541.841872371768;10548.789024219319;10550.419726915094;10556.947215263874;9251;9322.114399132071;9409.247260219028;9428.245740340893;9590.184834288884;9080.455172689659;9191.082770717634;9193.310501712265;9432;9478.620855165716;8111;8132.430729848854;8153.9184608153155;8204.794880128045;8291.626876790438;5763.538916886555;5789.884202316014;5935.614185077956;5975.880482390415;5991.2510936132985;5846.590738648254;5864.179014937998;5886.3525012247765;5961.791337303347;6039.909401359071 09:11:12 INFO - PID 17806 | |4;prototype.html;394.85193052605274;395.2391646081293;398.30694591410946;399.65629558579616;405.3979839937692;5977.641341519512;5993.250843644544;6003.369646187148;6052.485538729203;6054.8486287842825;5639.15412688097;5827.1550625159325;5873.1190321451695;5883.99916042818;5910.940890591093;4633.096546173498;4639.118567472186;4644.651651126179;4645.953540464586;4666.393368862043;4659.091477161955;4668.669429212675;4668.953310466886;4674.205385084527;4693.460252071021;4505.43682039745;4585.77071146443;4590.517995610463;4602.907941841161;4603.8260243638;4572.08558288342;4572.15415148197;4574.885627859297;4581.3815134956685;4596.862094137181;4113.506379234511;4114.300568903263;4135.359019352005;4143.3784932260105;4148.854790082332;5617.943820561783;5732.770689172428;5733.226014488074;5738.8278351649515;5842.298924129089;5376.51611354976;5378.515933565998;5394.676319420808;5400.648957817729;5412.296401467784;5947.881042379171;6236.409715522513;6285.2457705075685;6310.432061114522;6310.589811662273;4309.267424537836;4340.110277393158;4375.824967001348;4378.8905277368;4405.845795397177;6290.779822706229;6540.215174179129;6555.93444065558;6645.003249512563;6652.966735166342;4001.4998125234347;4356.629686476622;4358.106588149421;4366.672499562482;4375.081232941118;4500.639948804153;4516.796744146522;4523.819047238074;4530.88672783183;4542.137723533336;5224.7126408047925;5227.18978558324;5229.686218826882;5234.842954711365;5250.97374513125;6222.502199824004;6283.858061065855;6294.42639340165;6321.778737744157;6370.394812492806;1563.335582377485;1577.1877483096214;1580.1546172797498;1582.8971116877367;1584.2633175573415;1003.9648612298535;1026.9691909242736;1040.1003132290666;1053.4679986606868;1056.2183983851894;5933.792317268875;5957.314908785458;5966.970165149147;5971.820845374646;6000.909986350208;6465.547411681137;6470.741170353227;6482.837929051811;6490.350964903566;6494.772682956074;5811;5878.911816322759;5893.970530147321;5922.289325280908;5934.1692163097205;3384;3421.4354631486026;3434.914127146841;3437;3440.8989123480246;6587.002913674267;6588.769393071219;6636.701348439332;6696.832579185462;6713.1944166700305;6582.8856964397255;6583.604983700993;6588.308227636125;6616;6651.866962660816;6513.837154071186;6640.501962352843;6668.133142691419;6687.866242675119;6755.729770809113;6468.223813142453;6504.869902602016;6512.869742605216;6524.934750652433;6529;6187.257529096357;6418.29398766126;6421.261554921244;6437.710303036468;6462.3537646235;6673.231593627595;6752.696128674123;6756.763513277012;6778.559393639398;6785.796426107225;4440.844570440148;4444.666650001198;4450.243458611979;4462.955370446254;4473.105378924163;6394.616323020634;6533.509986750918;6546.607203567801;6553.705083271359;6573.605583664996;6331.366863313816;6350.952092904804;6359.459445947146;6363.809085727436;6377.23473183221;6011.977963746261;6283.96858015707;6355.428011478989;6372.394622510854;6396.10454536356;6270.341614130633;6280.183576135256;6317.368263173646;6325.652089134957;6341.143945567474;6253.187085678833;6344.651044192614;6377.1390862233;6378.553501255054;6434.742610295536;6163.84590385244;6174.38256174379;6212.844678882883;6220.595661282002;6228.128062071223 09:11:12 INFO - PID 17806 | |5;yui.html;755.1127425275301;773.1727052054302;780.4575819805234;785.4266385538554;795.6220795122317;15304.387824487021;15469.690606187884;16104.677906441864;16107.43623973161;16132.838671613295;15817.209139543034;15932.52202433926;15949.601259968507;15954.361825526965;15987.280572374242;814.0922870998853;828.3331917806164;829.1625458287114;845.9915400845974;852.4160949749411;856.546030603781;859.4628357276702;860.793409581699;861.0872475176302;863.5380071661663;894.3337213775746;895.2211575928951;896.2426749396749;897.5153417154729;897.7890195803981;892.892852857658;894.516960841145;894.5750768384997;895.154079394972;895.7805337692307;646.360103497534;649.8862699027699;651.9445847103002;654.2149420695184;655.9737610495574;16372.83627163725;16473.588160295967;16682.082485463296;17636.91181544097;17784;16072;16086.195690215442;16418.425355112515;16428.67142657152;16614.83385166145;11867.465964031639;12215.694607634792;12397.318147501885;12670.113092083559;13074.215547067206;3156.1793933577205;3214.694604012615;3220.581324427833;3243.708066274023;3273.2307907641684;85754;87681;87697.12302876954;87761.56119219426;90246.99999999935;11924.940375298242;11939.940300298444;12015.939920300518;12033.217840840318;12216.938915305367;25833.354166145997;25864;25891;26007.60988585173;26242.343941401617;7743.148253692089;7777.222277772177;7786.688532458751;7802.414818888606;7923.762287131395;3674.9448758268645;3693.9261214776093;3700.5189325388064;3748.11919198988;3761.5486141663177;4073.2668119738137;4190.1200747843295;4191.119864828359;4406.581374769392;4572.222722137245;804.0994086622903;809.0695699944993;819.8524265632124;826.0459169659053;833.2667252817482;647.9870402591922;664.8803215421174;665.7736369634348;677.4106527321163;702.6908160409506;10309.381437113798;10428.585667297886;10619.256652034283;10634.361938283728;11297.548098075986;666.4372047548491;667.9499037572201;669.6852479334705;670.852412469256;682.3697927028162;4462.620677242471;4777.259524773665;4851.951480485221;5327.41951559851;5672;74298.62850685712;74742;74908;78009.21990780134;80447.59776201198;58718;70402.64798676076;71793.64103179555;72287.63856180686;72751.63624181846;52422.213666795025;56847.14729279064;56997.14504282439;58393.41606583965;59119.40880591311;10840.620578279722;10966.122710183326;11065.391403472886;11228.494717737558;11238.438078095898;29505.26236844096;30611.859624021232;30657.846710767197;31280.374392512476;32266.35467290688;38673.58569800174;38864.6113538861;39161.804190978866;39181.80409097936;39703;14070.929645351707;14208.502702405367;14273.857261427253;14475.855241447873;15117.697646047238;14922.477713279983;15150;15640.687186256439;15728.134952577719;15830.129342885792;14338.56984290473;14719.705605888037;14960.551183464513;15669.921650391676;15693.136877471848;14377.496787612383;15019.77470337924;15076.095434273979;15534.84465155334;15593.940845407808;13943.58169254924;14559.12645241289;14577.416903323749;14583.197924114276;15180.772288415903;11897.286162830258;12408.937955310166;12659.87340126587;12736.87263127394;13043.739125217253;10492.737681557717;11505.712357190803;12018.579349722717;12106.273623582612;12132.393380330772 09:11:12 INFO - PID 17806 | __end_tp_report 09:11:12 INFO - PID 17806 | __start_cc_report 09:11:12 INFO - PID 17806 | _x_x_mozilla_cycle_collect,1211 09:11:12 INFO - PID 17806 | __end_cc_report 09:11:12 INFO - PID 17806 | __startTimestamp1490199072551__endTimestamp 09:11:12 INFO - PID 17806 | 09:11:12 INFO - PID 17806 | ------- Summary: start ------- 09:11:12 INFO - PID 17806 | Number of tests: 6 09:11:12 INFO - PID 17806 | 09:11:12 INFO - PID 17806 | [#0] dojo.html Cycles:165 Average:5720.93 Median:6014.07 stddev:672.49 (11.2%) stddev-sans-first:645.90 09:11:12 INFO - PID 17806 | Values: 3245.4 3256.0 3266.6 3303.8 3331.5 5721.7 5752.3 5765.5 5769.9 5781.3 5657.8 5704.9 5719.9 5753.8 5765.7 4942.1 5080.6 5157.2 5161.7 5197.1 5213.5 5262.8 5273.9 5287.2 5300.4 5060.8 5065.8 5133.2 5137.5 5183.0 5133.6 5150.2 5174.7 5224.5 5249.9 5094.8 5135.6 5155.4 5173.3 5187.8 5631.0 5653.1 5661.7 5751.2 5757.8 6118.4 6147.7 6214.0 6215.8 6222.1 6294.2 6295.3 6300.4 6305.6 6312.7 5712.1 5811.9 5816.0 5832.1 5878.5 6241.3 6322.5 6349.0 6402.3 6407.5 6057.3 6057.8 6060.6 6110.2 6119.8 6101.4 6108.5 6157.4 6158.8 6169.6 6111.7 6122.6 6142.0 6146.1 6147.6 6154.2 6196.8 6199.3 6211.9 6216.9 4735.5 4738.8 4740.1 4768.4 4781.6 4185.7 4207.6 4215.5 4217.7 4239.0 5775.4 5811.1 5864.8 5868.5 5874.5 6134.7 6186.5 6193.4 6202.8 6220.0 5793.7 5794.9 5795.4 5795.8 5807.6 5215.8 5216.7 5245.8 5264.9 5282.5 6437.1 6451.5 6456.4 6458.9 6472.0 6139.8 6161.8 6162.8 6261.9 6267.7 6323.9 6328.5 6332.1 6393.1 6399.0 6020.8 6064.1 6184.5 6190.8 6195.9 6105.2 6110.9 6141.2 6155.5 6157.6 6019.6 6033.2 6033.5 6036.7 6075.0 5997.7 6014.1 6018.9 6027.3 6039.3 5994.3 6070.9 6095.4 6099.7 6119.2 6037.5 6041.0 6044.5 6047.7 6067.7 5789.7 5791.0 5844.2 5848.2 5882.5 09:11:12 INFO - PID 17806 | 09:11:12 INFO - PID 17806 | [#1] ext.html Cycles:180 Average:42768.20 Median:35880.87 stddev:71151.61 (198.3%) stddev-sans-first:71280.92 09:11:12 INFO - PID 17806 | Values: 646.8 700.4 718.2 1098.3 1118.1 29851.4 35836.8 36685.8 36702.0 36853.8 42845.0 43375.6 43407.6 43429.8 43493.3 5899.3 8140.0 8301.0 8309.4 8314.1 6051.5 7477.5 7492.1 7514.3 7568.6 7578.2 7609.4 7615.5 7616.0 7627.4 5788.3 7535.7 7583.6 7585.2 7604.9 5938.0 7619.4 7808.1 7810.5 7821.9 36639.3 36828.3 36907.3 36967.6 37232.4 2951.4 2998.3 3021.7 3028.4 3059.4 25990.0 26223.7 28021.6 28876.4 29404.4 3604.2 3606.1 3625.8 3635.7 3697.9 213655.0 213659.0 214608.0 214747.0 214825.0 50323.2 50362.7 50478.0 50552.0 50676.7 52459.0 52466.0 52604.7 52629.7 52724.5 14346.9 14355.2 14414.4 14477.7 14486.2 9864.9 10010.3 11531.6 11554.4 11593.1 11428.1 11532.7 12326.9 12520.9 12607.8 5107.6 5265.2 5305.5 5370.8 5388.4 1035.7 1040.7 1044.7 1045.2 1089.5 25388.7 25421.4 25854.2 25855.2 25917.7 1135.3 1143.9 1144.3 1172.4 1187.4 13053.2 13135.5 13318.9 13404.4 13463.7 289509.0 290975.0 292296.0 292462.0 292530.0 54260.5 54340.5 54394.0 54490.2 54563.5 1416.6 1447.2 1449.1 1472.7 1496.8 23613.4 23671.3 24893.4 25331.5 25335.5 38836.2 38860.4 38927.8 38972.8 39007.8 299409.0 300890.0 301385.0 301406.0 301813.0 31139.5 31648.5 31813.4 31830.8 33572.7 34155.7 39441.6 39618.8 40549.4 43160.6 35394.6 36559.5 36668.3 36926.8 38168.2 35924.9 36653.5 36865.0 36997.6 38119.0 35812.0 36258.0 36712.3 36805.4 37876.2 28764.9 30616.5 30898.4 31454.0 31549.7 26167.3 26214.0 26221.4 26281.2 26576.5 09:11:12 INFO - PID 17806 | 09:11:12 INFO - PID 17806 | [#2] jquery.html Cycles:180 Average:32918.87 Median:21674.78 stddev:95563.62 (440.9%) stddev-sans-first:95800.55 09:11:12 INFO - PID 17806 | Values: 421.2 435.3 441.2 444.5 464.6 19019.5 20270.6 20909.0 21070.9 21097.4 19372.4 21507.4 21618.5 21649.8 21699.8 5940.6 6186.6 6196.2 6199.0 6204.9 5965.5 6093.8 6121.2 6132.6 6133.1 6093.0 6106.1 6110.5 6110.8 6113.4 5872.1 6101.8 6136.4 6148.6 6149.7 5495.0 5505.9 5538.9 5548.8 5552.6 25319.4 25331.9 25594.0 25669.5 25703.9 2082.2 2090.7 2091.3 2092.5 2137.3 15158.8 15997.4 16162.2 16498.5 16668.3 1862.2 1869.6 1874.6 1886.2 1887.7 91262.5 91683.0 92030.0 92570.5 93732.5 12033.4 12141.8 12151.9 12303.4 12487.0 17633.7 17645.9 17667.1 17679.4 17683.5 8424.1 8586.0 8642.5 8696.1 8741.4 7716.4 7746.7 7927.8 8001.4 8020.6 7506.9 7601.4 7767.8 7776.5 7837.5 2192.5 2267.8 2279.4 2281.6 2342.0 1020.5 1024.4 1024.7 1036.8 1041.8 19952.0 20140.5 20169.6 20234.5 20602.0 1041.7 1046.2 1054.6 1070.6 1073.4 10167.2 11077.1 11152.8 11156.3 11206.7 572249.0 572840.0 574231.0 575756.0 613178.0 60618.1 64798.0 93989.0 103855.0 105630.5 1076.8 1158.3 1227.4 1229.7 1237.4 19980.1 20284.2 20539.9 20906.0 20942.7 48147.5 48165.3 49021.0 49050.3 49502.8 63574.7 63764.4 64524.7 64911.4 66145.7 9037.4 9043.0 9271.7 9297.7 9682.6 14216.3 14417.0 14526.8 14620.2 14672.7 11860.7 11995.8 12010.9 12420.1 12942.2 12096.5 12245.9 12312.2 12478.0 12607.0 11301.0 12063.0 12478.2 12671.8 12991.0 9449.2 9546.8 9595.6 9713.0 9805.9 12609.7 12793.5 12840.2 12848.5 12887.7 09:11:12 INFO - PID 17806 | 09:11:12 INFO - PID 17806 | [#3] mootools.html Cycles:180 Average:6884.57 Median:3058.02 stddev:4329.92 (141.6%) stddev-sans-first:4321.65 09:11:12 INFO - PID 17806 | Values: 1288.8 1346.0 1365.5 1366.4 1366.6 10306.8 10694.9 10703.0 10706.4 10711.9 10550.7 10877.1 10907.5 10913.2 10917.5 2388.6 2451.9 2457.3 2459.0 2461.9 2050.2 2125.9 2342.7 2411.9 2415.1 2365.3 2427.1 2431.3 2434.7 2434.8 2387.0 2405.6 2414.6 2415.1 2439.3 2312.5 2333.1 2402.5 2412.6 2415.4 11023.7 11063.4 11106.2 11132.7 11169.5 6025.4 6135.5 6147.2 6160.2 6210.6 3812.3 3812.8 3924.2 3947.5 3978.9 1311.3 1314.7 1317.9 1349.7 1376.6 15550.3 15571.5 15749.7 15917.6 15937.7 5092.2 5282.4 5285.2 5305.8 5386.5 11780.1 11800.4 11805.4 11809.4 11811.3 6067.1 6195.1 6205.7 6214.3 6219.3 5628.7 5693.0 5706.1 5770.2 5889.4 4191.4 4288.4 4308.7 4363.1 4377.1 1112.8 1147.7 1215.6 1226.1 1267.8 768.7 773.1 776.7 800.8 814.8 5993.5 6059.3 6198.5 6268.6 6417.9 921.7 931.2 935.4 943.1 973.1 3654.2 3682.7 3697.0 3727.4 3852.2 14178.9 14601.6 14633.9 14635.2 14649.1 13532.1 13869.2 14025.3 14538.0 14549.3 9633.4 9778.8 9894.8 9918.7 10188.0 6251.9 6423.4 6464.7 6558.3 6757.1 12041.3 12231.6 12408.0 12721.8 12806.1 12457.5 12795.9 12908.9 13248.1 13387.3 9090.1 9126.7 9223.4 9234.7 9238.6 10397.6 10541.8 10548.8 10550.4 10556.9 9251.0 9322.1 9409.2 9428.2 9590.2 9080.5 9191.1 9193.3 9432.0 9478.6 8111.0 8132.4 8153.9 8204.8 8291.6 5763.5 5789.9 5935.6 5975.9 5991.3 5846.6 5864.2 5886.4 5961.8 6039.9 09:11:12 INFO - PID 17806 | 09:11:12 INFO - PID 17806 | [#4] prototype.html Cycles:180 Average:5273.20 Median:5941.03 stddev:1579.13 (26.6%) stddev-sans-first:1540.53 09:11:12 INFO - PID 17806 | Values: 394.9 395.2 398.3 399.7 405.4 5977.6 5993.3 6003.4 6052.5 6054.8 5639.2 5827.2 5873.1 5884.0 5910.9 4633.1 4639.1 4644.7 4646.0 4666.4 4659.1 4668.7 4669.0 4674.2 4693.5 4505.4 4585.8 4590.5 4602.9 4603.8 4572.1 4572.2 4574.9 4581.4 4596.9 4113.5 4114.3 4135.4 4143.4 4148.9 5617.9 5732.8 5733.2 5738.8 5842.3 5376.5 5378.5 5394.7 5400.6 5412.3 5947.9 6236.4 6285.2 6310.4 6310.6 4309.3 4340.1 4375.8 4378.9 4405.8 6290.8 6540.2 6555.9 6645.0 6653.0 4001.5 4356.6 4358.1 4366.7 4375.1 4500.6 4516.8 4523.8 4530.9 4542.1 5224.7 5227.2 5229.7 5234.8 5251.0 6222.5 6283.9 6294.4 6321.8 6370.4 1563.3 1577.2 1580.2 1582.9 1584.3 1004.0 1027.0 1040.1 1053.5 1056.2 5933.8 5957.3 5967.0 5971.8 6000.9 6465.5 6470.7 6482.8 6490.4 6494.8 5811.0 5878.9 5894.0 5922.3 5934.2 3384.0 3421.4 3434.9 3437.0 3440.9 6587.0 6588.8 6636.7 6696.8 6713.2 6582.9 6583.6 6588.3 6616.0 6651.9 6513.8 6640.5 6668.1 6687.9 6755.7 6468.2 6504.9 6512.9 6524.9 6529.0 6187.3 6418.3 6421.3 6437.7 6462.4 6673.2 6752.7 6756.8 6778.6 6785.8 4440.8 4444.7 4450.2 4463.0 4473.1 6394.6 6533.5 6546.6 6553.7 6573.6 6331.4 6351.0 6359.5 6363.8 6377.2 6012.0 6284.0 6355.4 6372.4 6396.1 6270.3 6280.2 6317.4 6325.7 6341.1 6253.2 6344.7 6377.1 6378.6 6434.7 6163.8 6174.4 6212.8 6220.6 6228.1 09:11:12 INFO - PID 17806 | 09:11:12 INFO - PID 17806 | [#5] yui.html Cycles:180 Average:17428.96 Median:3684.44 stddev:21775.48 (591.0%) stddev-sans-first:21800.57 09:11:12 INFO - PID 17806 | Values: 755.1 773.2 780.5 785.4 795.6 15304.4 15469.7 16104.7 16107.4 16132.8 15817.2 15932.5 15949.6 15954.4 15987.3 814.1 828.3 829.2 846.0 852.4 856.5 859.5 860.8 861.1 863.5 894.3 895.2 896.2 897.5 897.8 892.9 894.5 894.6 895.2 895.8 646.4 649.9 651.9 654.2 656.0 16372.8 16473.6 16682.1 17636.9 17784.0 16072.0 16086.2 16418.4 16428.7 16614.8 11867.5 12215.7 12397.3 12670.1 13074.2 3156.2 3214.7 3220.6 3243.7 3273.2 85754.0 87681.0 87697.1 87761.6 90247.0 11924.9 11939.9 12015.9 12033.2 12216.9 25833.4 25864.0 25891.0 26007.6 26242.3 7743.1 7777.2 7786.7 7802.4 7923.8 3674.9 3693.9 3700.5 3748.1 3761.5 4073.3 4190.1 4191.1 4406.6 4572.2 804.1 809.1 819.9 826.0 833.3 648.0 664.9 665.8 677.4 702.7 10309.4 10428.6 10619.3 10634.4 11297.5 666.4 667.9 669.7 670.9 682.4 4462.6 4777.3 4852.0 5327.4 5672.0 74298.6 74742.0 74908.0 78009.2 80447.6 58718.0 70402.6 71793.6 72287.6 72751.6 52422.2 56847.1 56997.1 58393.4 59119.4 10840.6 10966.1 11065.4 11228.5 11238.4 29505.3 30611.9 30657.8 31280.4 32266.4 38673.6 38864.6 39161.8 39181.8 39703.0 14070.9 14208.5 14273.9 14475.9 15117.7 14922.5 15150.0 15640.7 15728.1 15830.1 14338.6 14719.7 14960.6 15669.9 15693.1 14377.5 15019.8 15076.1 15534.8 15593.9 13943.6 14559.1 14577.4 14583.2 15180.8 11897.3 12408.9 12659.9 12736.9 13043.7 10492.7 11505.7 12018.6 12106.3 12132.4 09:11:12 INFO - PID 17806 | -------- Summary: end -------- 09:11:12 INFO - PID 17806 | 09:11:13 INFO - TEST-INFO | 17806: exit 0 09:11:13 INFO - TEST-OK | dromaeo_css | took 1116428ms 09:11:13 INFO - TEST-START | kraken 09:11:13 INFO - operating with platform_type : linux_ 09:11:13 INFO - Initialising browser for kraken test... 09:11:13 INFO - TEST-INFO | started process 18130 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKJbxf2/profile http://localhost:34260/getInfo.html) 09:11:17 INFO - PID 18130 | __metrics Screen width/height:1600/1200 09:11:17 INFO - PID 18130 | colorDepth:24 09:11:17 INFO - PID 18130 | Browser inner width/height: 1024/697 09:11:17 INFO - PID 18130 | __metrics 09:11:18 INFO - PID 18130 | 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" 09:11:18 INFO - PID 18130 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:11:19 INFO - TEST-INFO | 18130: exit 0 09:11:19 INFO - Browser initialized. 09:11:19 INFO - Running cycle 1/1 for kraken test... 09:11:19 INFO - TEST-INFO | started process 18225 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKJbxf2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:11:31 INFO - PID 18225 | RSS: Main: 145268736 09:11:31 INFO - PID 18225 | 09:11:33 INFO - PID 18225 | Cycle 1(1): loaded http://localhost:34260/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34260/tests/kraken/driver.html?testName=audio-beat-detection) 09:11:34 INFO - PID 18225 | RSS: Main: 200331264 09:11:34 INFO - PID 18225 | 09:11:37 INFO - PID 18225 | Cycle 1(1): loaded http://localhost:34260/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34260/tests/kraken/driver.html?testName=audio-dft) 09:11:37 INFO - PID 18225 | RSS: Main: 179531776 09:11:37 INFO - PID 18225 | 09:11:40 INFO - PID 18225 | Cycle 1(1): loaded http://localhost:34260/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34260/tests/kraken/driver.html?testName=audio-fft) 09:11:41 INFO - PID 18225 | RSS: Main: 261791744 09:11:41 INFO - PID 18225 | 09:11:43 INFO - PID 18225 | Cycle 1(1): loaded http://localhost:34260/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34260/tests/kraken/driver.html?testName=audio-oscillator) 09:11:43 INFO - PID 18225 | RSS: Main: 173076480 09:11:43 INFO - PID 18225 | 09:11:46 INFO - PID 18225 | Cycle 1(1): loaded http://localhost:34260/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34260/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:11:46 INFO - PID 18225 | RSS: Main: 176357376 09:11:46 INFO - PID 18225 | 09:11:49 INFO - PID 18225 | Cycle 1(1): loaded http://localhost:34260/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34260/tests/kraken/driver.html?testName=imaging-darkroom) 09:11:50 INFO - PID 18225 | RSS: Main: 215838720 09:11:50 INFO - PID 18225 | 09:11:53 INFO - PID 18225 | Cycle 1(1): loaded http://localhost:34260/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34260/tests/kraken/driver.html?testName=imaging-desaturate) 09:11:54 INFO - PID 18225 | RSS: Main: 228892672 09:11:54 INFO - PID 18225 | 09:11:57 INFO - PID 18225 | Cycle 1(1): loaded http://localhost:34260/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34260/tests/kraken/driver.html?testName=json-parse-financial) 09:11:57 INFO - PID 18225 | RSS: Main: 241315840 09:11:57 INFO - PID 18225 | 09:11:59 INFO - PID 18225 | Cycle 1(1): loaded http://localhost:34260/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34260/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:11:59 INFO - PID 18225 | RSS: Main: 177999872 09:11:59 INFO - PID 18225 | 09:12:01 INFO - PID 18225 | Cycle 1(1): loaded http://localhost:34260/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34260/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:12:02 INFO - PID 18225 | RSS: Main: 185102336 09:12:02 INFO - PID 18225 | 09:12:04 INFO - PID 18225 | Cycle 1(1): loaded http://localhost:34260/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34260/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:12:04 INFO - PID 18225 | RSS: Main: 194289664 09:12:04 INFO - PID 18225 | 09:12:07 INFO - PID 18225 | Cycle 1(1): loaded http://localhost:34260/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34260/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:12:08 INFO - PID 18225 | RSS: Main: 203005952 09:12:08 INFO - PID 18225 | 09:12:11 INFO - PID 18225 | Cycle 1(1): loaded http://localhost:34260/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34260/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:12:11 INFO - PID 18225 | RSS: Main: 199602176 09:12:11 INFO - PID 18225 | 09:12:13 INFO - PID 18225 | Cycle 1(1): loaded http://localhost:34260/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34260/tests/kraken/driver.html?testName=ai-astar) 09:12:13 INFO - PID 18225 | RSS: Main: 269074432 09:12:13 INFO - PID 18225 | 09:12:13 INFO - PID 18225 | __start_tp_report 09:12:13 INFO - PID 18225 | _x_x_mozilla_page_load 09:12:13 INFO - PID 18225 | _x_x_mozilla_page_load_details 09:12:13 INFO - PID 18225 | |i|pagename|runs| 09:12:13 INFO - PID 18225 | |0;ai-astar;101;109;108;108;112;110;108;108;108;110 09:12:13 INFO - PID 18225 | |1;audio-beat-detection;140;118;118;169;117;123;117;117;142;120 09:12:13 INFO - PID 18225 | |2;audio-dft;161;163;161;161;162;161;163;165;163;163 09:12:13 INFO - PID 18225 | |3;audio-fft;74;74;75;110;76;75;76;74;92;74 09:12:13 INFO - PID 18225 | |4;audio-oscillator;83;83;106;82;83;85;95;83;84;111 09:12:13 INFO - PID 18225 | |5;imaging-gaussian-blur;114;113;113;113;113;113;113;112;113;114 09:12:13 INFO - PID 18225 | |6;imaging-darkroom;147;147;146;147;146;147;146;146;146;147 09:12:13 INFO - PID 18225 | |7;imaging-desaturate;94;94;94;93;94;94;94;94;94;93 09:12:13 INFO - PID 18225 | |8;json-parse-financial;58;57;55;56;58;58;56;57;56;57 09:12:13 INFO - PID 18225 | |9;json-stringify-tinderbox;56;56;55;55;55;55;55;55;56;59 09:12:13 INFO - PID 18225 | |10;stanford-crypto-aes;79;79;79;80;80;81;79;79;78;78 09:12:13 INFO - PID 18225 | |11;stanford-crypto-ccm;133;129;125;125;125;125;124;126;175;126 09:12:13 INFO - PID 18225 | |12;stanford-crypto-pbkdf2;183;183;182;182;182;180;181;182;183;185 09:12:13 INFO - PID 18225 | |13;stanford-crypto-sha256-iterative;66;64;66;65;66;65;64;64;63;65 09:12:13 INFO - PID 18225 | __end_tp_report 09:12:13 INFO - PID 18225 | __start_cc_report 09:12:13 INFO - PID 18225 | _x_x_mozilla_cycle_collect,1750 09:12:13 INFO - PID 18225 | __end_cc_report 09:12:13 INFO - PID 18225 | __startTimestamp1490199133581__endTimestamp 09:12:13 INFO - PID 18225 | 09:12:13 INFO - PID 18225 | ------- Summary: start ------- 09:12:13 INFO - PID 18225 | Number of tests: 14 09:12:13 INFO - PID 18225 | 09:12:13 INFO - PID 18225 | [#0] ai-astar Cycles:10 Average:108.20 Median:108.50 stddev:2.86 (2.6%) stddev-sans-first:1.41 09:12:13 INFO - PID 18225 | Values: 101.0 109.0 108.0 108.0 112.0 110.0 108.0 108.0 108.0 110.0 09:12:13 INFO - PID 18225 | 09:12:13 INFO - PID 18225 | [#1] audio-beat-detection Cycles:10 Average:128.10 Median:121.50 stddev:17.23 (14.2%) stddev-sans-first:17.73 09:12:13 INFO - PID 18225 | Values: 140.0 118.0 118.0 169.0 117.0 123.0 117.0 117.0 142.0 120.0 09:12:13 INFO - PID 18225 | 09:12:13 INFO - PID 18225 | [#2] audio-dft Cycles:10 Average:162.30 Median:163.00 stddev:1.34 (0.8%) stddev-sans-first:1.33 09:12:13 INFO - PID 18225 | Values: 161.0 163.0 161.0 161.0 162.0 161.0 163.0 165.0 163.0 163.0 09:12:13 INFO - PID 18225 | 09:12:13 INFO - PID 18225 | [#3] audio-fft Cycles:10 Average:80.00 Median:75.00 stddev:11.88 (15.8%) stddev-sans-first:12.40 09:12:13 INFO - PID 18225 | Values: 74.0 74.0 75.0 110.0 76.0 75.0 76.0 74.0 92.0 74.0 09:12:13 INFO - PID 18225 | 09:12:13 INFO - PID 18225 | [#4] audio-oscillator Cycles:10 Average:89.50 Median:83.00 stddev:10.75 (13.0%) stddev-sans-first:11.14 09:12:13 INFO - PID 18225 | Values: 83.0 83.0 106.0 82.0 83.0 85.0 95.0 83.0 84.0 111.0 09:12:13 INFO - PID 18225 | 09:12:13 INFO - PID 18225 | [#5] imaging-gaussian-blur Cycles:10 Average:113.10 Median:113.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 09:12:13 INFO - PID 18225 | Values: 114.0 113.0 113.0 113.0 113.0 113.0 113.0 112.0 113.0 114.0 09:12:13 INFO - PID 18225 | 09:12:13 INFO - PID 18225 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 09:12:13 INFO - PID 18225 | Values: 147.0 147.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 147.0 09:12:13 INFO - PID 18225 | 09:12:13 INFO - PID 18225 | [#7] imaging-desaturate Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 09:12:13 INFO - PID 18225 | Values: 94.0 94.0 94.0 93.0 94.0 94.0 94.0 94.0 94.0 93.0 09:12:13 INFO - PID 18225 | 09:12:13 INFO - PID 18225 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:57.00 stddev:1.03 (1.8%) stddev-sans-first:1.00 09:12:13 INFO - PID 18225 | Values: 58.0 57.0 55.0 56.0 58.0 58.0 56.0 57.0 56.0 57.0 09:12:13 INFO - PID 18225 | 09:12:13 INFO - PID 18225 | [#9] json-stringify-tinderbox Cycles:10 Average:55.70 Median:55.50 stddev:1.25 (2.3%) stddev-sans-first:1.32 09:12:13 INFO - PID 18225 | Values: 56.0 56.0 55.0 55.0 55.0 55.0 55.0 55.0 56.0 59.0 09:12:13 INFO - PID 18225 | 09:12:13 INFO - PID 18225 | [#10] stanford-crypto-aes Cycles:10 Average:79.20 Median:79.00 stddev:0.92 (1.2%) stddev-sans-first:0.97 09:12:13 INFO - PID 18225 | Values: 79.0 79.0 79.0 80.0 80.0 81.0 79.0 79.0 78.0 78.0 09:12:13 INFO - PID 18225 | 09:12:13 INFO - PID 18225 | [#11] stanford-crypto-ccm Cycles:10 Average:131.30 Median:126.00 stddev:15.59 (12.4%) stddev-sans-first:16.52 09:12:13 INFO - PID 18225 | Values: 133.0 129.0 125.0 125.0 125.0 125.0 124.0 126.0 175.0 126.0 09:12:13 INFO - PID 18225 | 09:12:13 INFO - PID 18225 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.30 Median:182.50 stddev:1.34 (0.7%) stddev-sans-first:1.39 09:12:13 INFO - PID 18225 | Values: 183.0 183.0 182.0 182.0 182.0 180.0 181.0 182.0 183.0 185.0 09:12:13 INFO - PID 18225 | 09:12:13 INFO - PID 18225 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:1.03 (1.6%) stddev-sans-first:1.00 09:12:13 INFO - PID 18225 | Values: 66.0 64.0 66.0 65.0 66.0 65.0 64.0 64.0 63.0 65.0 09:12:13 INFO - PID 18225 | -------- Summary: end -------- 09:12:13 INFO - PID 18225 | 09:12:14 INFO - TEST-INFO | 18225: exit 0 09:12:14 INFO - TEST-OK | kraken | took 61425ms 09:12:14 INFO - SUITE-END | took 1177s 09:12:14 INFO - Completed test suite (00:19:37) 09:12:14 INFO - javascript benchmark 09:12:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7532.346402786523, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3245.4320493913565, 3255.983720081402, 3266.591676040495, 3303.752218583607, 3331.466965285553, 5721.656700597967, 5752.28096487939, 5765.481106700396, 5769.855753606157, 5781.277340332458, 5657.801976930808, 5704.857378565538, 5719.914201286984, 5753.798617048405, 5765.6540607563575, 4942.135126352892, 5080.644354895159, 5157.226416037587, 5161.690298582078, 5197.116490196657, 5213.504717051874, 5262.842114736564, 5273.86815329616, 5287.180487024498, 5300.443453437391, 5060.797568097271, 5065.848024559269, 5133.204353325241, 5137.460566640524, 5183.041137389576, 5133.563647090002, 5150.227465880111, 5174.663646862942, 5224.529792318672, 5249.895002099936, 5094.770735316883, 5135.589152867799, 5155.355580552431, 5173.275741396207, 5187.844364669028, 5631.0, 5653.067243904751, 5661.716914154317, 5751.194832723422, 5757.798477053283, 6118.43644382056, 6147.661878596676, 6214.036824292242, 6215.844603884894, 6222.12890195373, 6294.150289710876, 6295.276043254993, 6300.369963003663, 6305.621662700252, 6312.747490100391, 5712.057510510719, 5811.88376232473, 5816.0, 5832.096025116114, 5878.470937615592, 6241.251049873953, 6322.4942004639515, 6349.0, 6402.327755585689, 6407.519436042222, 6057.3336932937345, 6057.7879774207695, 6060.606060606046, 6110.205673262448, 6119.816405507842, 6101.420365065312, 6108.5418593605655, 6157.353477884758, 6158.753649854045, 6169.56813023084, 6111.694415279218, 6122.621817257929, 6142.04798256271, 6146.078088286793, 6147.569670123138, 6154.169187159676, 6196.845078872974, 6199.287081985539, 6211.9068213976825, 6216.937830621636, 4735.455422626374, 4738.763061846894, 4740.146773580788, 4768.380110585602, 4781.569658730661, 4185.686073544435, 4207.642350400189, 4215.515215750228, 4217.662586993033, 4239.0, 5775.364709881909, 5811.070228763462, 5864.794732184353, 5868.501177399969, 5874.50066744323, 6134.723937422827, 6186.505079593621, 6193.38066193377, 6202.751889924352, 6220.0, 5793.652380857162, 5794.942050579524, 5795.362510123883, 5795.768169273266, 5807.564432667482, 5215.843524694265, 5216.739163041909, 5245.816396426107, 5264.868378290574, 5282.4717528246865, 6437.130987316652, 6451.483881289486, 6456.418922296922, 6458.903116453163, 6472.029195620695, 6139.829471381233, 6161.84595385119, 6162.784302549389, 6261.906071408841, 6267.749290028531, 6323.873522529616, 6328.46208072319, 6332.11350410952, 6393.1369265148605, 6399.008153736178, 6020.759169633341, 6064.090386442069, 6184.536159787944, 6190.783322583688, 6195.907061393992, 6105.186826067751, 6110.923300256584, 6141.240538582456, 6155.538334624832, 6157.599756015845, 6019.608725432833, 6033.185519954925, 6033.5173186145885, 6036.7283472244735, 6074.969625151846, 5997.730102145327, 6014.0678194879865, 6018.9398106020135, 6027.30685971119, 6039.305479869696, 5994.250718660168, 6070.908936366046, 6095.408112664776, 6099.746340301087, 6119.2350956130485, 6037.516998640011, 6040.969795151172, 6044.546659000504, 6047.727852246748, 6067.726952287246, 5789.681567513827, 5791.044477661138, 5844.240248767633, 5848.239728835224, 5882.470577648032], "value": 5673.890037794739, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.7510008646669, 700.439648281375, 718.1848601836915, 1098.2586753941089, 1118.0720002398011, 29851.402971940548, 35836.82081589592, 36685.76342021856, 36702.0, 36853.81573092138, 42845.0, 43375.56624433755, 43407.56592434075, 43429.82850857452, 43493.34759978603, 5899.262592175978, 8139.959300203505, 8300.958495207546, 8309.376796740238, 8314.127016663255, 6051.485623721989, 7477.513961592506, 7492.100947886262, 7514.323710866049, 7568.583727894964, 7578.242175782433, 7609.4292928030345, 7615.543067415945, 7616.0, 7627.389808815309, 5788.305403351625, 7535.660895259699, 7583.582902940336, 7585.1656317805, 7604.923950760504, 5937.970310148465, 7619.352355049828, 7808.102068262109, 7810.453268271223, 7821.882671759929, 36639.267214655825, 36828.263434731154, 36907.261854763026, 36967.630323696685, 37232.44151337705, 2951.38021015587, 2998.295400580862, 3021.7129372709555, 3028.424599326121, 3059.4187104450084, 25990.0, 26223.73776262251, 28021.57967630487, 28876.42247155045, 29404.411911761646, 3604.2250916052913, 3606.0804494853905, 3625.8368373422995, 3635.7273204509765, 3697.944530832013, 213655.0, 213659.0, 214608.0, 214747.0, 214825.0, 50323.24515132276, 50362.74818625957, 50478.0, 50552.0, 50676.74661626668, 52459.0, 52466.0, 52604.736976314874, 52629.7368513155, 52724.47275527272, 14346.856531434762, 14355.210463424612, 14414.351354188877, 14477.710445791236, 14486.203258820655, 9864.852027219598, 10010.299279050396, 11531.596394126165, 11554.364509952033, 11593.072554195644, 11428.142889283337, 11532.654020379403, 12326.938365308117, 12520.937395312965, 12607.810882836764, 5107.591392688576, 5265.210218467184, 5305.469453054664, 5370.838874833761, 5388.353397592314, 1035.6777582491711, 1040.6877936618985, 1044.7127040064042, 1045.1951996962448, 1089.5260561655705, 25388.746112539007, 25421.364465888502, 25854.224373268833, 25855.224343269732, 25917.74082259191, 1135.28477059452, 1143.9027682647068, 1144.2619510415734, 1172.407933993328, 1187.3647598534742, 13053.216806991612, 13135.474581016844, 13318.866811331956, 13404.396802143732, 13463.730725385438, 289509.0, 290975.0, 292296.0, 292462.0, 292530.0, 54260.45739542633, 54340.45659543354, 54394.0, 54490.18264726032, 54563.45436545663, 1416.6033510617044, 1447.232966527742, 1449.1232804153547, 1472.6539263273123, 1496.8428315026983, 23613.409664758517, 23671.289861304187, 24893.377665558506, 25331.493370132124, 25335.493290133727, 38836.223275534896, 38860.41709374418, 38927.80536097415, 38972.80513597414, 39007.80496097615, 299409.0, 300890.0, 301385.0, 301406.0, 301813.0, 31139.53290700596, 31648.5252721214, 31813.363732724752, 31830.84084579562, 33572.66427335695, 34155.65844341624, 39441.60558394379, 39618.80190599029, 40549.39175912423, 43160.568394315655, 35394.64605353914, 36559.45160822537, 36668.26663466769, 36926.815365923, 38168.236635266585, 35924.91689369871, 36653.450198246515, 36865.0, 36997.6300237005, 38119.0, 35812.0, 36258.00580968072, 36712.265754684224, 36805.44791828071, 37876.242475150895, 28764.856175719826, 30616.540751888293, 30898.38203235878, 31454.0, 31549.684503154676, 26167.345816354744, 26214.0, 26221.373098776465, 26281.21156365312, 26576.468470630094], "value": 17142.688319415458, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [421.2270483662479, 435.3448060668694, 441.2212445034515, 444.5021575835065, 464.57027249793936, 19019.524511887208, 20270.59458810823, 20909.0, 21070.89464552679, 21097.367078987634, 19372.418827435165, 21507.354779356607, 21618.459538511546, 21649.783502164973, 21699.783002169974, 5940.613860099091, 6186.597871138361, 6196.194494715681, 6198.969005154991, 6204.937950620504, 5965.4929331006915, 6093.78671746489, 6121.173641558399, 6132.601380910249, 6133.080037994292, 6092.969535152318, 6106.145139680449, 6110.511159107283, 6110.786122485714, 6113.419225173601, 5872.0898260769645, 6101.847453813668, 6136.386361363872, 6148.600340977822, 6149.661768602725, 5494.972525137388, 5505.944940550583, 5538.889222215533, 5548.77804887804, 5552.611317207797, 25319.36701582475, 25331.873340633178, 25594.0, 25669.486610267875, 25703.871480642665, 2082.1983536338466, 2090.675945228492, 2091.309867743656, 2092.529180934293, 2137.2840098567, 15158.848411515854, 15997.440089596808, 16162.191890405433, 16498.505044848553, 16668.33326666932, 1862.1992543206416, 1869.5886904880904, 1874.5594785225462, 1886.2455017992775, 1887.7257850950552, 91262.5436872818, 91683.0, 92030.0, 92570.53714731384, 93732.53133734356, 12033.39833008346, 12141.817872731915, 12151.878481215252, 12303.384830758427, 12487.0, 17633.677474189488, 17645.911770441067, 17667.084930986242, 17679.381221657437, 17683.469495914887, 8424.115467875907, 8585.957070214608, 8642.524661143698, 8696.086910874394, 8741.431806932529, 7716.382689384835, 7746.690132394641, 7927.841443171104, 8001.439899207, 8020.598970051474, 7506.887396689054, 7601.353884919733, 7767.805804854924, 7776.5334079954255, 7837.451378403457, 2192.471286694759, 2267.7958983691547, 2279.404416908171, 2281.6349384098467, 2341.988290058573, 1020.5203554329453, 1024.416082832793, 1024.6721049264313, 1036.8335622424772, 1041.796849614333, 19952.0, 20140.496487587636, 20169.59660806805, 20234.494137646383, 20602.0, 1041.6770801051546, 1046.1630695443614, 1054.5570860238718, 1070.6306324318098, 1073.4203530093819, 10167.186625069977, 11077.119948813366, 11152.776944461066, 11156.274842135235, 11206.719832004102, 572249.0, 572840.0, 574231.0, 575756.0, 613178.0, 60618.08679934797, 64798.0, 93989.0, 103855.0, 105630.47184764026, 1076.784643071389, 1158.2876530933415, 1227.355638289887, 1229.661842993184, 1237.3503910447087, 19980.100895459447, 20284.188632454538, 20539.897300513403, 20906.0, 20942.68585971181, 48147.5185248143, 48165.27752083651, 49021.0, 49050.26424603562, 49502.75248623734, 63574.68212658907, 63764.362356375845, 64524.67737661282, 64911.35088649242, 66145.66927165333, 9037.367384283038, 9042.954785226295, 9271.721848344561, 9297.72106836796, 9682.612695492102, 14216.289185540889, 14417.0, 14526.782098268746, 14620.195889226196, 14672.706545869236, 11860.703482413008, 11995.760084798081, 12010.939945300217, 12420.130590858553, 12942.158759680591, 12096.45565949552, 12245.877541224474, 12312.199707019374, 12478.0, 12607.0, 11301.0, 12063.0, 12478.18891772032, 12671.80992285135, 12991.0, 9449.196818270524, 9546.761330966781, 9595.616175352907, 9713.0, 9805.852912206465, 12609.65950133275, 12793.488260469849, 12840.229586224856, 12848.486060557472, 12887.677808054874], "value": 10132.32635498996, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1288.8388951381078, 1345.9932700336503, 1365.5493687083263, 1366.3851266929885, 1366.5558693424634, 10306.845397319037, 10694.946525267382, 10703.036726694596, 10706.41114738689, 10711.892881071188, 10550.683479495608, 10877.129829613632, 10907.509162087705, 10913.23607347486, 10917.454127293624, 2388.6297623868286, 2451.9019239230497, 2457.2751038443703, 2458.963115553268, 2461.876906154694, 2050.2209160519055, 2125.8724476531456, 2342.672025916373, 2411.8794060297005, 2415.130553000918, 2365.266767302142, 2427.1262345555588, 2431.2706188143575, 2434.732179460258, 2434.7808697217247, 2386.95226095478, 2405.579023670851, 2414.5895197816412, 2415.130553000918, 2439.292605144506, 2312.5028118954338, 2333.0667732906804, 2402.5435167318155, 2412.6139817629096, 2415.3961509622595, 11023.724406889813, 11063.446827658665, 11106.222564420494, 11132.666020019413, 11169.497372618252, 6025.367336429699, 6135.509159267248, 6147.200863887666, 6160.1991741073825, 6210.5963112398, 3812.2566099610585, 3812.752171108869, 3924.1955399143108, 3947.46709194258, 3978.8607398740905, 1311.3246677960763, 1314.6581888709004, 1317.9209247445183, 1349.6760777413351, 1376.600785772125, 15550.300236489385, 15571.454999074978, 15749.685006299924, 15917.602059948595, 15937.681246375123, 5092.2361645753435, 5282.366116066097, 5285.154375299933, 5305.840824775263, 5386.5152136307925, 11780.057595392347, 11800.350980695972, 11805.409729513662, 11809.409529523662, 11811.291322520676, 6067.089936509471, 6195.132681424604, 6205.6586887721605, 6214.285357183981, 6219.346968568326, 5628.662280263197, 5692.971535142297, 5706.144078388275, 5770.163326317745, 5889.440503152194, 4191.350340697197, 4288.4210631564965, 4308.655307575386, 4363.149185908781, 4377.146456440963, 1112.777444511101, 1147.7245461089447, 1215.6292330839003, 1226.1171956191529, 1267.7971524556026, 768.74247127213, 773.083895583735, 776.6970881356276, 800.7877912353231, 814.8085199978001, 5993.460588547052, 6059.333473317932, 6198.535109866688, 6268.561200715997, 6417.871642567123, 921.7004473546124, 931.1759093202564, 935.4100362943083, 943.1228957069991, 973.1096047116808, 3654.1595433050547, 3682.705383569308, 3696.963030369716, 3727.440883867387, 3852.24881148179, 14178.929105354613, 14601.634959126106, 14633.926830365994, 14635.195064271355, 14649.12105273687, 13532.120412173374, 13869.167849929037, 14025.298735063207, 14538.0, 14549.272536373139, 9633.421994680202, 9778.804423911482, 9894.752631184278, 9918.652847150315, 10187.994541610242, 6251.937480625135, 6423.357664233727, 6464.709088090953, 6558.311377305315, 6757.087793147862, 12041.277523348626, 12231.571894983634, 12408.0, 12721.80917286223, 12806.103572750191, 12457.501699931901, 12795.93602031984, 12908.935455322664, 13248.072634915463, 13387.330633468093, 9090.090990900857, 9126.726198214064, 9223.44659320443, 9234.722958311262, 9238.630454781733, 10397.584096636352, 10541.841872371768, 10548.789024219319, 10550.419726915094, 10556.947215263874, 9251.0, 9322.114399132071, 9409.247260219028, 9428.245740340893, 9590.184834288884, 9080.455172689659, 9191.082770717634, 9193.310501712265, 9432.0, 9478.620855165716, 8111.0, 8132.430729848854, 8153.9184608153155, 8204.794880128045, 8291.626876790438, 5763.538916886555, 5789.884202316014, 5935.614185077956, 5975.880482390415, 5991.2510936132985, 5846.590738648254, 5864.179014937998, 5886.3525012247765, 5961.791337303347, 6039.909401359071], "value": 5213.575774590145, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [394.85193052605274, 395.2391646081293, 398.30694591410946, 399.65629558579616, 405.3979839937692, 5977.641341519512, 5993.250843644544, 6003.369646187148, 6052.485538729203, 6054.8486287842825, 5639.15412688097, 5827.1550625159325, 5873.1190321451695, 5883.99916042818, 5910.940890591093, 4633.096546173498, 4639.118567472186, 4644.651651126179, 4645.953540464586, 4666.393368862043, 4659.091477161955, 4668.669429212675, 4668.953310466886, 4674.205385084527, 4693.460252071021, 4505.43682039745, 4585.77071146443, 4590.517995610463, 4602.907941841161, 4603.8260243638, 4572.08558288342, 4572.15415148197, 4574.885627859297, 4581.3815134956685, 4596.862094137181, 4113.506379234511, 4114.300568903263, 4135.359019352005, 4143.3784932260105, 4148.854790082332, 5617.943820561783, 5732.770689172428, 5733.226014488074, 5738.8278351649515, 5842.298924129089, 5376.51611354976, 5378.515933565998, 5394.676319420808, 5400.648957817729, 5412.296401467784, 5947.881042379171, 6236.409715522513, 6285.2457705075685, 6310.432061114522, 6310.589811662273, 4309.267424537836, 4340.110277393158, 4375.824967001348, 4378.8905277368, 4405.845795397177, 6290.779822706229, 6540.215174179129, 6555.93444065558, 6645.003249512563, 6652.966735166342, 4001.4998125234347, 4356.629686476622, 4358.106588149421, 4366.672499562482, 4375.081232941118, 4500.639948804153, 4516.796744146522, 4523.819047238074, 4530.88672783183, 4542.137723533336, 5224.7126408047925, 5227.18978558324, 5229.686218826882, 5234.842954711365, 5250.97374513125, 6222.502199824004, 6283.858061065855, 6294.42639340165, 6321.778737744157, 6370.394812492806, 1563.335582377485, 1577.1877483096214, 1580.1546172797498, 1582.8971116877367, 1584.2633175573415, 1003.9648612298535, 1026.9691909242736, 1040.1003132290666, 1053.4679986606868, 1056.2183983851894, 5933.792317268875, 5957.314908785458, 5966.970165149147, 5971.820845374646, 6000.909986350208, 6465.547411681137, 6470.741170353227, 6482.837929051811, 6490.350964903566, 6494.772682956074, 5811.0, 5878.911816322759, 5893.970530147321, 5922.289325280908, 5934.1692163097205, 3384.0, 3421.4354631486026, 3434.914127146841, 3437.0, 3440.8989123480246, 6587.002913674267, 6588.769393071219, 6636.701348439332, 6696.832579185462, 6713.1944166700305, 6582.8856964397255, 6583.604983700993, 6588.308227636125, 6616.0, 6651.866962660816, 6513.837154071186, 6640.501962352843, 6668.133142691419, 6687.866242675119, 6755.729770809113, 6468.223813142453, 6504.869902602016, 6512.869742605216, 6524.934750652433, 6529.0, 6187.257529096357, 6418.29398766126, 6421.261554921244, 6437.710303036468, 6462.3537646235, 6673.231593627595, 6752.696128674123, 6756.763513277012, 6778.559393639398, 6785.796426107225, 4440.844570440148, 4444.666650001198, 4450.243458611979, 4462.955370446254, 4473.105378924163, 6394.616323020634, 6533.509986750918, 6546.607203567801, 6553.705083271359, 6573.605583664996, 6331.366863313816, 6350.952092904804, 6359.459445947146, 6363.809085727436, 6377.23473183221, 6011.977963746261, 6283.96858015707, 6355.428011478989, 6372.394622510854, 6396.10454536356, 6270.341614130633, 6280.183576135256, 6317.368263173646, 6325.652089134957, 6341.143945567474, 6253.187085678833, 6344.651044192614, 6377.1390862233, 6378.553501255054, 6434.742610295536, 6163.84590385244, 6174.38256174379, 6212.844678882883, 6220.595661282002, 6228.128062071223], "value": 4775.327491619038, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.1127425275301, 773.1727052054302, 780.4575819805234, 785.4266385538554, 795.6220795122317, 15304.387824487021, 15469.690606187884, 16104.677906441864, 16107.43623973161, 16132.838671613295, 15817.209139543034, 15932.52202433926, 15949.601259968507, 15954.361825526965, 15987.280572374242, 814.0922870998853, 828.3331917806164, 829.1625458287114, 845.9915400845974, 852.4160949749411, 856.546030603781, 859.4628357276702, 860.793409581699, 861.0872475176302, 863.5380071661663, 894.3337213775746, 895.2211575928951, 896.2426749396749, 897.5153417154729, 897.7890195803981, 892.892852857658, 894.516960841145, 894.5750768384997, 895.154079394972, 895.7805337692307, 646.360103497534, 649.8862699027699, 651.9445847103002, 654.2149420695184, 655.9737610495574, 16372.83627163725, 16473.588160295967, 16682.082485463296, 17636.91181544097, 17784.0, 16072.0, 16086.195690215442, 16418.425355112515, 16428.67142657152, 16614.83385166145, 11867.465964031639, 12215.694607634792, 12397.318147501885, 12670.113092083559, 13074.215547067206, 3156.1793933577205, 3214.694604012615, 3220.581324427833, 3243.708066274023, 3273.2307907641684, 85754.0, 87681.0, 87697.12302876954, 87761.56119219426, 90246.99999999935, 11924.940375298242, 11939.940300298444, 12015.939920300518, 12033.217840840318, 12216.938915305367, 25833.354166145997, 25864.0, 25891.0, 26007.60988585173, 26242.343941401617, 7743.148253692089, 7777.222277772177, 7786.688532458751, 7802.414818888606, 7923.762287131395, 3674.9448758268645, 3693.9261214776093, 3700.5189325388064, 3748.11919198988, 3761.5486141663177, 4073.2668119738137, 4190.1200747843295, 4191.119864828359, 4406.581374769392, 4572.222722137245, 804.0994086622903, 809.0695699944993, 819.8524265632124, 826.0459169659053, 833.2667252817482, 647.9870402591922, 664.8803215421174, 665.7736369634348, 677.4106527321163, 702.6908160409506, 10309.381437113798, 10428.585667297886, 10619.256652034283, 10634.361938283728, 11297.548098075986, 666.4372047548491, 667.9499037572201, 669.6852479334705, 670.852412469256, 682.3697927028162, 4462.620677242471, 4777.259524773665, 4851.951480485221, 5327.41951559851, 5672.0, 74298.62850685712, 74742.0, 74908.0, 78009.21990780134, 80447.59776201198, 58718.0, 70402.64798676076, 71793.64103179555, 72287.63856180686, 72751.63624181846, 52422.213666795025, 56847.14729279064, 56997.14504282439, 58393.41606583965, 59119.40880591311, 10840.620578279722, 10966.122710183326, 11065.391403472886, 11228.494717737558, 11238.438078095898, 29505.26236844096, 30611.859624021232, 30657.846710767197, 31280.374392512476, 32266.35467290688, 38673.58569800174, 38864.6113538861, 39161.804190978866, 39181.80409097936, 39703.0, 14070.929645351707, 14208.502702405367, 14273.857261427253, 14475.855241447873, 15117.697646047238, 14922.477713279983, 15150.0, 15640.687186256439, 15728.134952577719, 15830.129342885792, 14338.56984290473, 14719.705605888037, 14960.551183464513, 15669.921650391676, 15693.136877471848, 14377.496787612383, 15019.77470337924, 15076.095434273979, 15534.84465155334, 15593.940845407808, 13943.58169254924, 14559.12645241289, 14577.416903323749, 14583.197924114276, 15180.772288415903, 11897.286162830258, 12408.937955310166, 12659.87340126587, 12736.87263127394, 13043.739125217253, 10492.737681557717, 11505.712357190803, 12018.579349722717, 12106.273623582612, 12132.393380330772], "value": 7442.904707345231, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1491.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 109.0, 108.0, 108.0, 112.0, 110.0, 108.0, 108.0, 108.0, 110.0], "value": 108.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 118.0, 118.0, 169.0, 117.0, 123.0, 117.0, 117.0, 142.0, 120.0], "value": 128.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 161.0, 161.0, 162.0, 161.0, 163.0, 165.0, 163.0, 163.0], "value": 162.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 110.0, 76.0, 75.0, 76.0, 74.0, 92.0, 74.0], "value": 80.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 106.0, 82.0, 83.0, 85.0, 95.0, 83.0, 84.0, 111.0], "value": 89.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0, 113.0, 114.0], "value": 113.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 57.0, 55.0, 56.0, 58.0, 58.0, 56.0, 57.0, 56.0, 57.0], "value": 56.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 56.0, 59.0], "value": 55.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 79.0, 80.0, 80.0, 81.0, 79.0, 79.0, 78.0, 78.0], "value": 79.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 129.0, 125.0, 125.0, 125.0, 125.0, 124.0, 126.0, 175.0, 126.0], "value": 131.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 183.0, 182.0, 182.0, 182.0, 180.0, 181.0, 182.0, 183.0, 185.0], "value": 182.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 66.0, 65.0, 66.0, 65.0, 64.0, 64.0, 63.0, 65.0], "value": 64.8, "unit": "score"}]}]} 09:12:14 INFO - Return code: 0 09:12:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:12:14 ERROR - # TBPL SUCCESS # 09:12:14 INFO - Running post-action listener: _resource_record_post_action 09:12:14 INFO - [mozharness: 2017-03-22 16:12:14.888946Z] Finished run-tests step (success) 09:12:14 INFO - Running post-run listener: _resource_record_post_run 09:12:14 INFO - Total resource usage - Wall time: 1195s; CPU: 13.0%; Read bytes: 0; Write bytes: 368775168; Read time: 0; Write time: 295060 09:12:14 INFO - TinderboxPrint: CPU usage
12.9% 09:12:14 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:12:14 INFO - TinderboxPrint: I/O write bytes / time
368,775,168 / 295,060 09:12:14 INFO - TinderboxPrint: CPU idle
8,306.7 (87.1%) 09:12:14 INFO - TinderboxPrint: CPU user
1,184.7 (12.4%) 09:12:14 INFO - TinderboxPrint: Swap in / out
0 / 0 09:12:14 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 54353920; Read time: 0; Write time: 54888 09:12:14 INFO - run-tests - Wall time: 1178s; CPU: 13.0%; Read bytes: 0; Write bytes: 254844928; Read time: 0; Write time: 211496 09:12:15 INFO - Running post-run listener: _upload_blobber_files 09:12:15 INFO - Blob upload gear active. 09:12:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:12:15 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:12:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:12:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:12:15 INFO - (blobuploader) - INFO - Open directory for files ... 09:12:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:12:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:12:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:16 INFO - (blobuploader) - INFO - Done attempting. 09:12:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:12:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:12:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:17 INFO - (blobuploader) - INFO - Done attempting. 09:12:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:12:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:12:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:18 INFO - (blobuploader) - INFO - Done attempting. 09:12:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:12:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:12:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:12:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:12:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:12:22 INFO - (blobuploader) - INFO - Done attempting. 09:12:22 INFO - (blobuploader) - INFO - Iteration through files over. 09:12:22 INFO - Return code: 0 09:12:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:12:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:12:22 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8effcbb4d6c3c121f1646d726e5d90677d49b8120933e6562aec56639fd4127ceb4c9ec856e48f7d759d5c00764c0f0a4624f393839e062c3eaed0485a980b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe3fdd3973a00e4bf016df6c9ce5e079bf9ad11d2cab9f701c00e3d883d091d34830aa86359f55f6753a61b055ff185a3193bc4c35241b3bb1f6f603800d75a7", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cbdc2d6b16b8653aecb4d05128f6dd9b7515c0bc6e4e102163e2b94d95faf46f31b33fe41a387795fc3ef7856ead812b12108e47d3b138fcd19e1ae07c95d3dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0190c20545c3e6226fdf3997f0213f406550fd4d6f0902882da9e2a7914df111cd922301305dc3c11cddb7c5b52cae1a41c8b7aa4ff06bd873f948100ff0bbab"} 09:12:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:12:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:12:22 INFO - Contents: 09:12:22 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8effcbb4d6c3c121f1646d726e5d90677d49b8120933e6562aec56639fd4127ceb4c9ec856e48f7d759d5c00764c0f0a4624f393839e062c3eaed0485a980b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe3fdd3973a00e4bf016df6c9ce5e079bf9ad11d2cab9f701c00e3d883d091d34830aa86359f55f6753a61b055ff185a3193bc4c35241b3bb1f6f603800d75a7", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cbdc2d6b16b8653aecb4d05128f6dd9b7515c0bc6e4e102163e2b94d95faf46f31b33fe41a387795fc3ef7856ead812b12108e47d3b138fcd19e1ae07c95d3dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0190c20545c3e6226fdf3997f0213f406550fd4d6f0902882da9e2a7914df111cd922301305dc3c11cddb7c5b52cae1a41c8b7aa4ff06bd873f948100ff0bbab"} 09:12:22 INFO - Running post-run listener: copy_logs_to_upload_dir 09:12:22 INFO - Copying logs to upload dir... 09:12:22 INFO - mkdir: /builds/slave/test/build/upload/logs 09:12:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.083718 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-03-22 09:12:22.077275) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 09:12:22.081471) ========= 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=14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8effcbb4d6c3c121f1646d726e5d90677d49b8120933e6562aec56639fd4127ceb4c9ec856e48f7d759d5c00764c0f0a4624f393839e062c3eaed0485a980b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe3fdd3973a00e4bf016df6c9ce5e079bf9ad11d2cab9f701c00e3d883d091d34830aa86359f55f6753a61b055ff185a3193bc4c35241b3bb1f6f603800d75a7", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cbdc2d6b16b8653aecb4d05128f6dd9b7515c0bc6e4e102163e2b94d95faf46f31b33fe41a387795fc3ef7856ead812b12108e47d3b138fcd19e1ae07c95d3dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0190c20545c3e6226fdf3997f0213f406550fd4d6f0902882da9e2a7914df111cd922301305dc3c11cddb7c5b52cae1a41c8b7aa4ff06bd873f948100ff0bbab"} build_url:https://queue.taskcluster.net/v1/task/cX3r_vUeQnyvTX1YGVjIgA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011280 build_url: 'https://queue.taskcluster.net/v1/task/cX3r_vUeQnyvTX1YGVjIgA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b8effcbb4d6c3c121f1646d726e5d90677d49b8120933e6562aec56639fd4127ceb4c9ec856e48f7d759d5c00764c0f0a4624f393839e062c3eaed0485a980b6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fe3fdd3973a00e4bf016df6c9ce5e079bf9ad11d2cab9f701c00e3d883d091d34830aa86359f55f6753a61b055ff185a3193bc4c35241b3bb1f6f603800d75a7", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cbdc2d6b16b8653aecb4d05128f6dd9b7515c0bc6e4e102163e2b94d95faf46f31b33fe41a387795fc3ef7856ead812b12108e47d3b138fcd19e1ae07c95d3dd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0190c20545c3e6226fdf3997f0213f406550fd4d6f0902882da9e2a7914df111cd922301305dc3c11cddb7c5b52cae1a41c8b7aa4ff06bd873f948100ff0bbab"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-22 09:12:22.110989) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 09:12:22.111597) ========= 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=14ef55db36f7623abb31b9cf000001d5-1490197880.176120-1685498825 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004563 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-22 09:12:22.188904) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 09:12:22.189237) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-22 09:12:22.189525) ========= ========= Total master_lag: 0.20 =========