builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-058 starttime: 1489580808.53 results: success (0) revision: 0cc9dced786cf2a3baeff707b636b4ad02637df0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 05:26:48.529696) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 05:26:48.530196) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 05:26:48.530467) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 05:26:48.545430) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 05:26:48.545829) ========= 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=0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-15 05:26:49-- 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% 45.8M=0s 2017-03-15 05:26:49 (45.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.078469 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 05:26:48.639053) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 05:26:48.639395) ========= 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=0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016428 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 05:26:48.689067) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-15 05:26:48.689399) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0cc9dced786cf2a3baeff707b636b4ad02637df0 --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 0cc9dced786cf2a3baeff707b636b4ad02637df0 --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=0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-15 05:26:49,312 truncating revision to first 12 chars 2017-03-15 05:26:49,312 Setting DEBUG logging. 2017-03-15 05:26:49,312 attempt 1/10 2017-03-15 05:26:49,312 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0cc9dced786c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-15 05:26:50,011 unpacking tar archive at: mozilla-central-0cc9dced786c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.005123 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-15 05:26:49.707522) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 05:26:49.707941) ========= script_repo_revision: 0cc9dced786cf2a3baeff707b636b4ad02637df0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 05:26:49.708588) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 05:26:49.709075) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 05:26:49.720133) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-15 05:26:49.720581) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:26:50 INFO - MultiFileLogger online at 20170315 05:26:50 in /builds/slave/test 05:26:50 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 05:26:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:26:50 INFO - {'append_to_log': False, 05:26:50 INFO - 'base_work_dir': '/builds/slave/test', 05:26:50 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:26:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:26:50 INFO - 'branch': 'Firefox-Non-PGO', 05:26:50 INFO - 'buildbot_json_path': 'buildprops.json', 05:26:50 INFO - 'config_files': ('talos/linux_config.py',), 05:26:50 INFO - 'default_actions': ('clobber', 05:26:50 INFO - 'read-buildbot-config', 05:26:50 INFO - 'download-and-extract', 05:26:50 INFO - 'populate-webroot', 05:26:50 INFO - 'create-virtualenv', 05:26:50 INFO - 'install', 05:26:50 INFO - 'run-tests'), 05:26:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:26:50 INFO - 'download_minidump_stackwalk': True, 05:26:50 INFO - 'download_symbols': 'ondemand', 05:26:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:26:50 INFO - 'tooltool.py': '/tools/tooltool.py', 05:26:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:26:50 INFO - '/tools/misc-python/virtualenv.py')}, 05:26:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:26:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:26:50 INFO - 'gecko_profile': False, 05:26:50 INFO - 'gecko_profile_interval': 0, 05:26:50 INFO - 'installer_path': 'installer.exe', 05:26:50 INFO - 'log_level': 'info', 05:26:50 INFO - 'log_name': 'talos', 05:26:50 INFO - 'log_to_console': True, 05:26:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:26:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:26:50 INFO - 'opt_config_files': (), 05:26:50 INFO - 'pip_index': False, 05:26:50 INFO - 'suite': 'dromaeojs', 05:26:50 INFO - 'system_bits': '32', 05:26:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:26:50 INFO - 'title': 'talos-linux64-ix-058', 05:26:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:26:50 INFO - 'use_talos_json': True, 05:26:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:26:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:26:50 INFO - 'work_dir': 'build'} 05:26:50 INFO - [mozharness: 2017-03-15 12:26:50.436150Z] Running clobber step. 05:26:50 INFO - Running pre-action listener: _resource_record_pre_action 05:26:50 INFO - Running main action method: clobber 05:26:50 INFO - rmtree: /builds/slave/test/build 05:26:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:26:51 INFO - Running post-action listener: _resource_record_post_action 05:26:51 INFO - [mozharness: 2017-03-15 12:26:51.474996Z] Finished clobber step (success) 05:26:51 INFO - [mozharness: 2017-03-15 12:26:51.475096Z] Running read-buildbot-config step. 05:26:51 INFO - Running pre-action listener: _resource_record_pre_action 05:26:51 INFO - Running main action method: read_buildbot_config 05:26:51 INFO - Using buildbot properties: 05:26:51 INFO - { 05:26:51 INFO - "project": "", 05:26:51 INFO - "product": "firefox", 05:26:51 INFO - "who": "cbook@mozilla.com", 05:26:51 INFO - "installer_path": "public/build/target.tar.bz2", 05:26:51 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:26:51 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:26:51 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 05:26:51 INFO - "stage_platform": "linux64", 05:26:51 INFO - "basedir": "/builds/slave/test", 05:26:51 INFO - "buildnumber": 876, 05:26:51 INFO - "platform": "ubuntu64_hw", 05:26:51 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 05:26:51 INFO - "slavebuilddir": "test", 05:26:51 INFO - "taskId": "Is2WdD_QRrumXlgxENWLwQ", 05:26:51 INFO - "branch": "mozilla-central", 05:26:51 INFO - "script_repo_revision": "production", 05:26:51 INFO - "revision": "0cc9dced786cf2a3baeff707b636b4ad02637df0", 05:26:51 INFO - "slavename": "talos-linux64-ix-058", 05:26:51 INFO - "repo_path": "mozilla-central" 05:26:51 INFO - } 05:26:51 INFO - Finding installer, test and symbols from parent task. 05:26:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Is2WdD_QRrumXlgxENWLwQ'}, attempt #1 05:26:51 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Is2WdD_QRrumXlgxENWLwQ'}, attempt #1 05:26:52 INFO - Task dependencies: CcwqoAPJRTGe2QwjqJGbJQ 05:26:52 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ'}, attempt #1 05:26:52 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.tar.bz2 05:26:52 INFO - Set test_url: https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/test_packages.json 05:26:52 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.crashreporter-symbols.zip 05:26:52 INFO - Running post-action listener: _resource_record_post_action 05:26:52 INFO - [mozharness: 2017-03-15 12:26:52.892129Z] Finished read-buildbot-config step (success) 05:26:52 INFO - [mozharness: 2017-03-15 12:26:52.892347Z] Running download-and-extract step. 05:26:52 INFO - Running pre-action listener: _resource_record_pre_action 05:26:52 INFO - Running main action method: download_and_extract 05:26:52 INFO - mkdir: /builds/slave/test/build/tests 05:26:52 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')]} 05:26:52 INFO - trying https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.test_packages.json 05:26:52 INFO - Downloading https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:26:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:26:53 INFO - Downloaded 896 bytes. 05:26:53 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:26:53 INFO - Using the following test package requirements: 05:26:53 INFO - {u'common': [u'target.common.tests.zip'], 05:26:53 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:26:53 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:26:53 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:26:53 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:26:53 INFO - u'mozbase': [u'target.common.tests.zip'], 05:26:53 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:26:53 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:26:53 INFO - u'web-platform': [u'target.common.tests.zip', 05:26:53 INFO - u'target.web-platform.tests.zip'], 05:26:53 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:26:53 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:26:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.common.tests.zip 05:26:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:26:53 INFO - Fetch https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.common.tests.zip into memory 05:26:54 INFO - Expected file size: 58185609 05:26:54 INFO - Obtained file size: 58185609 05:27:04 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:27:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.common.tests.zip 05:27:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:27:04 INFO - Fetch https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.common.tests.zip into memory 05:27:05 INFO - Expected file size: 58185609 05:27:05 INFO - Obtained file size: 58185609 05:27:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.talos.tests.zip 05:27:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:27:16 INFO - Fetch https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.talos.tests.zip into memory 05:27:16 INFO - Expected file size: 14404452 05:27:16 INFO - Obtained file size: 14404452 05:27:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:17 INFO - trying https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.tar.bz2 05:27:17 INFO - Downloading https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:27:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:27:18 INFO - Downloaded 61742255 bytes. 05:27:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.tar.bz2 05:27:18 INFO - mkdir: /builds/slave/test/properties 05:27:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:27:18 INFO - Writing to file /builds/slave/test/properties/build_url 05:27:18 INFO - Contents: 05:27:18 INFO - build_url:https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.tar.bz2 05:27:18 INFO - Running post-action listener: _resource_record_post_action 05:27:18 INFO - Running post-action listener: set_extra_try_arguments 05:27:18 INFO - [mozharness: 2017-03-15 12:27:18.191655Z] Finished download-and-extract step (success) 05:27:18 INFO - [mozharness: 2017-03-15 12:27:18.191762Z] Running populate-webroot step. 05:27:18 INFO - Running pre-action listener: _resource_record_pre_action 05:27:18 INFO - Running main action method: populate_webroot 05:27:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:27:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:27:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:27:18 INFO - '--tppagecycles', 05:27:18 INFO - '7'], 05:27:18 INFO - 'tests': ['tsvgm']}}, 05:27:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:27:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:27:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:27:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:27:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:27:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:27:18 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:27:18 INFO - 'talos_options': ['--disable-e10s'], 05:27:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:27:18 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:27:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:27:18 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:27:18 INFO - 'talos_options': ['--disable-e10s'], 05:27:18 INFO - 'tests': ['damp', 'tps']}, 05:27:18 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:27:18 INFO - 'tests': ['damp', 'tps']}, 05:27:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:27:18 INFO - 'tests': ['dromaeo_dom']}, 05:27:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:27:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:27:18 INFO - 'tests': ['basic_compositor_video']}, 05:27:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:27:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:27:18 INFO - 'tests': ['a11yr', 05:27:18 INFO - 'ts_paint', 05:27:18 INFO - 'tpaint', 05:27:18 INFO - 'sessionrestore', 05:27:18 INFO - 'sessionrestore_no_auto_restore', 05:27:18 INFO - 'tabpaint']}, 05:27:18 INFO - 'other-e10s': {'tests': ['a11yr', 05:27:18 INFO - 'ts_paint', 05:27:18 INFO - 'tpaint', 05:27:18 INFO - 'sessionrestore', 05:27:18 INFO - 'sessionrestore_no_auto_restore', 05:27:18 INFO - 'tabpaint']}, 05:27:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:27:18 INFO - 'ts_paint', 05:27:18 INFO - 'tpaint', 05:27:18 INFO - 'sessionrestore', 05:27:18 INFO - 'sessionrestore_no_auto_restore', 05:27:18 INFO - 'tabpaint']}, 05:27:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:27:18 INFO - 'ts_paint', 05:27:18 INFO - 'tpaint', 05:27:18 INFO - 'sessionrestore', 05:27:18 INFO - 'sessionrestore_no_auto_restore', 05:27:18 INFO - 'tabpaint']}, 05:27:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:27:18 INFO - 'tests': ['a11yr', 05:27:18 INFO - 'ts_paint', 05:27:18 INFO - 'tpaint', 05:27:18 INFO - 'sessionrestore', 05:27:18 INFO - 'sessionrestore_no_auto_restore', 05:27:18 INFO - 'tabpaint']}, 05:27:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:27:18 INFO - 'tests': ['a11yr', 05:27:18 INFO - 'ts_paint', 05:27:18 INFO - 'tpaint', 05:27:18 INFO - 'sessionrestore', 05:27:18 INFO - 'sessionrestore_no_auto_restore', 05:27:18 INFO - 'tabpaint']}, 05:27:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:27:18 INFO - 'tests': ['tsvgx', 05:27:18 INFO - 'tsvgr_opacity', 05:27:18 INFO - 'tart', 05:27:18 INFO - 'tscrollx', 05:27:18 INFO - 'cart', 05:27:18 INFO - 'tsvg_static']}, 05:27:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:27:18 INFO - 'tsvgr_opacity', 05:27:18 INFO - 'tart', 05:27:18 INFO - 'tscrollx', 05:27:18 INFO - 'cart', 05:27:18 INFO - 'tsvg_static']}, 05:27:18 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:27:18 INFO - 'talos_options': ['--disable-e10s'], 05:27:18 INFO - 'tests': ['tp5o']}, 05:27:18 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:27:18 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:27:18 INFO - 'talos_options': ['--disable-e10s', 05:27:18 INFO - '--xperf_path', 05:27:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:27:18 INFO - 'tests': ['tp5n']}, 05:27:18 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:27:18 INFO - 'talos_options': ['--xperf_path', 05:27:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:27:18 INFO - 'tests': ['tp5n']}}, 05:27:18 INFO - 'talos.zip': {'path': '', 05:27:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:27:18 INFO - Running post-action listener: _resource_record_post_action 05:27:18 INFO - [mozharness: 2017-03-15 12:27:18.204922Z] Finished populate-webroot step (success) 05:27:18 INFO - [mozharness: 2017-03-15 12:27:18.205016Z] Running create-virtualenv step. 05:27:18 INFO - Running pre-action listener: _resource_record_pre_action 05:27:18 INFO - Running main action method: create_virtualenv 05:27:18 INFO - Creating virtualenv /builds/slave/test/build/venv 05:27:18 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 05:27:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:27:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:27:18 INFO - Using real prefix '/usr' 05:27:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:27:18 INFO - Installing distribute.............................................................................................................................................................................................done. 05:27:20 INFO - Installing pip.................done. 05:27:20 INFO - Return code: 0 05:27:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:27:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:27:20 INFO - Reading from file tmpfile_stdout 05:27:20 INFO - Output received: 05:27:20 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) 05:27:20 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:27:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:20 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 0x28661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b03b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b01290>, '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 0x2b01b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b02040>, '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': '0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467', '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 05:27:20 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 05:27:20 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 05:27:20 INFO - Using env: {'DISPLAY': ':0', 05:27:20 INFO - 'HOME': '/home/cltbld', 05:27:20 INFO - 'LANG': 'en_US.UTF-8', 05:27:20 INFO - 'LANGUAGE': 'en_US:en', 05:27:20 INFO - 'LOGNAME': 'cltbld', 05:27:20 INFO - 'MAIL': '/var/mail/cltbld', 05:27:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:20 INFO - 'MOZ_NO_REMOTE': '1', 05:27:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:20 INFO - 'NO_EM_RESTART': '1', 05:27:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:20 INFO - 'PWD': '/builds/slave/test', 05:27:20 INFO - 'SHELL': '/bin/bash', 05:27:20 INFO - 'SHLVL': '1', 05:27:20 INFO - 'TERM': 'linux', 05:27:20 INFO - 'TMOUT': '86400', 05:27:20 INFO - 'USER': 'cltbld', 05:27:20 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467', 05:27:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:20 INFO - '_': '/tools/buildbot/bin/python'} 05:27:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:21 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 05:27:21 INFO - Cleaning up... 05:27:21 INFO - Return code: 0 05:27:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b03b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b01290>, '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 0x2b01b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b02040>, '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': '0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467', '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 05:27:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:27:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:27:21 INFO - Using env: {'DISPLAY': ':0', 05:27:21 INFO - 'HOME': '/home/cltbld', 05:27:21 INFO - 'LANG': 'en_US.UTF-8', 05:27:21 INFO - 'LANGUAGE': 'en_US:en', 05:27:21 INFO - 'LOGNAME': 'cltbld', 05:27:21 INFO - 'MAIL': '/var/mail/cltbld', 05:27:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:21 INFO - 'MOZ_NO_REMOTE': '1', 05:27:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:21 INFO - 'NO_EM_RESTART': '1', 05:27:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:21 INFO - 'PWD': '/builds/slave/test', 05:27:21 INFO - 'SHELL': '/bin/bash', 05:27:21 INFO - 'SHLVL': '1', 05:27:21 INFO - 'TERM': 'linux', 05:27:21 INFO - 'TMOUT': '86400', 05:27:21 INFO - 'USER': 'cltbld', 05:27:21 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467', 05:27:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:21 INFO - '_': '/tools/buildbot/bin/python'} 05:27:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:21 INFO - Downloading/unpacking psutil>=3.1.1 05:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:27:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:27:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:27:23 INFO - Installing collected packages: psutil 05:27:23 INFO - Running setup.py install for psutil 05:27:23 INFO - building 'psutil._psutil_linux' extension 05:27:23 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 05:27:23 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 05:27:23 INFO - building 'psutil._psutil_posix' extension 05:27:23 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 05:27:23 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 05:27:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:27:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:27:24 INFO - Successfully installed psutil 05:27:24 INFO - Cleaning up... 05:27:24 INFO - Return code: 0 05:27:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:27: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')]} 05:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27: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')]} 05:27:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b03b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b01290>, '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 0x2b01b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b02040>, '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': '0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467', '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 05:27:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:27:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:27:24 INFO - Using env: {'DISPLAY': ':0', 05:27:24 INFO - 'HOME': '/home/cltbld', 05:27:24 INFO - 'LANG': 'en_US.UTF-8', 05:27:24 INFO - 'LANGUAGE': 'en_US:en', 05:27:24 INFO - 'LOGNAME': 'cltbld', 05:27:24 INFO - 'MAIL': '/var/mail/cltbld', 05:27:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:24 INFO - 'MOZ_NO_REMOTE': '1', 05:27:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:24 INFO - 'NO_EM_RESTART': '1', 05:27:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:24 INFO - 'PWD': '/builds/slave/test', 05:27:24 INFO - 'SHELL': '/bin/bash', 05:27:24 INFO - 'SHLVL': '1', 05:27:24 INFO - 'TERM': 'linux', 05:27:24 INFO - 'TMOUT': '86400', 05:27:24 INFO - 'USER': 'cltbld', 05:27:24 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467', 05:27:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:24 INFO - '_': '/tools/buildbot/bin/python'} 05:27:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:27:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:27:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:27:27 INFO - Installing collected packages: mozsystemmonitor 05:27:27 INFO - Running setup.py install for mozsystemmonitor 05:27:27 INFO - Successfully installed mozsystemmonitor 05:27:27 INFO - Cleaning up... 05:27:27 INFO - Return code: 0 05:27:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b03b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b01290>, '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 0x2b01b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b02040>, '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': '0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467', '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 05:27:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:27:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:27:27 INFO - Using env: {'DISPLAY': ':0', 05:27:27 INFO - 'HOME': '/home/cltbld', 05:27:27 INFO - 'LANG': 'en_US.UTF-8', 05:27:27 INFO - 'LANGUAGE': 'en_US:en', 05:27:27 INFO - 'LOGNAME': 'cltbld', 05:27:27 INFO - 'MAIL': '/var/mail/cltbld', 05:27:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:27 INFO - 'MOZ_NO_REMOTE': '1', 05:27:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:27 INFO - 'NO_EM_RESTART': '1', 05:27:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:27 INFO - 'PWD': '/builds/slave/test', 05:27:27 INFO - 'SHELL': '/bin/bash', 05:27:27 INFO - 'SHLVL': '1', 05:27:27 INFO - 'TERM': 'linux', 05:27:27 INFO - 'TMOUT': '86400', 05:27:27 INFO - 'USER': 'cltbld', 05:27:27 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467', 05:27:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:27 INFO - '_': '/tools/buildbot/bin/python'} 05:27:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:27 INFO - Downloading/unpacking jsonschema==2.5.1 05:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:27:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:27:29 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 05:27:29 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 05:27:29 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 05:27:29 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 05:27:29 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 05:27:29 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 05:27:30 INFO - Downloading functools32-3.2.3-2.tar.gz 05:27:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:27:30 INFO - warning: no files found matching '*.txt' 05:27:30 INFO - no previously-included directories found matching 'build' 05:27:30 INFO - no previously-included directories found matching 'dist' 05:27:30 INFO - no previously-included directories found matching '.git*' 05:27:30 INFO - Installing collected packages: jsonschema, functools32 05:27:30 INFO - Running setup.py install for functools32 05:27:30 INFO - warning: no files found matching '*.txt' 05:27:30 INFO - no previously-included directories found matching 'build' 05:27:30 INFO - no previously-included directories found matching 'dist' 05:27:30 INFO - no previously-included directories found matching '.git*' 05:27:30 INFO - Successfully installed jsonschema functools32 05:27:30 INFO - Cleaning up... 05:27:30 INFO - Return code: 0 05:27:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b03b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b01290>, '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 0x2b01b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b02040>, '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': '0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467', '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 05:27:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:27:30 INFO - Using env: {'DISPLAY': ':0', 05:27:30 INFO - 'HOME': '/home/cltbld', 05:27:30 INFO - 'LANG': 'en_US.UTF-8', 05:27:30 INFO - 'LANGUAGE': 'en_US:en', 05:27:30 INFO - 'LOGNAME': 'cltbld', 05:27:30 INFO - 'MAIL': '/var/mail/cltbld', 05:27:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:30 INFO - 'MOZ_NO_REMOTE': '1', 05:27:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:30 INFO - 'NO_EM_RESTART': '1', 05:27:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:30 INFO - 'PWD': '/builds/slave/test', 05:27:30 INFO - 'SHELL': '/bin/bash', 05:27:30 INFO - 'SHLVL': '1', 05:27:30 INFO - 'TERM': 'linux', 05:27:30 INFO - 'TMOUT': '86400', 05:27:30 INFO - 'USER': 'cltbld', 05:27:30 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467', 05:27:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:30 INFO - '_': '/tools/buildbot/bin/python'} 05:27:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:27:30 INFO - Cleaning up... 05:27:30 INFO - Return code: 0 05:27:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x28661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b03b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b01290>, '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 0x2b01b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b02040>, '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': '0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467', '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 05:27:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:27:30 INFO - Using env: {'DISPLAY': ':0', 05:27:30 INFO - 'HOME': '/home/cltbld', 05:27:30 INFO - 'LANG': 'en_US.UTF-8', 05:27:30 INFO - 'LANGUAGE': 'en_US:en', 05:27:30 INFO - 'LOGNAME': 'cltbld', 05:27:30 INFO - 'MAIL': '/var/mail/cltbld', 05:27:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:30 INFO - 'MOZ_NO_REMOTE': '1', 05:27:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:30 INFO - 'NO_EM_RESTART': '1', 05:27:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:30 INFO - 'PWD': '/builds/slave/test', 05:27:30 INFO - 'SHELL': '/bin/bash', 05:27:30 INFO - 'SHLVL': '1', 05:27:30 INFO - 'TERM': 'linux', 05:27:30 INFO - 'TMOUT': '86400', 05:27:30 INFO - 'USER': 'cltbld', 05:27:30 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467', 05:27:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:30 INFO - '_': '/tools/buildbot/bin/python'} 05:27:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:30 INFO - Downloading/unpacking blobuploader==1.2.4 05:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:32 INFO - Downloading blobuploader-1.2.4.tar.gz 05:27:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:27:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:27:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:27:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:27:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:27:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:27:33 INFO - Downloading docopt-0.6.1.tar.gz 05:27:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:27:33 INFO - Installing collected packages: blobuploader, requests, docopt 05:27:33 INFO - Running setup.py install for blobuploader 05:27:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:27:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:27:33 INFO - Running setup.py install for requests 05:27:34 INFO - Running setup.py install for docopt 05:27:34 INFO - Successfully installed blobuploader requests docopt 05:27:34 INFO - Cleaning up... 05:27:34 INFO - Return code: 0 05:27:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:34 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 0x28661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b03b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b01290>, '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 0x2b01b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b02040>, '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': '0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467', '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 05:27:34 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 05:27:34 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 05:27:34 INFO - Using env: {'DISPLAY': ':0', 05:27:34 INFO - 'HOME': '/home/cltbld', 05:27:34 INFO - 'LANG': 'en_US.UTF-8', 05:27:34 INFO - 'LANGUAGE': 'en_US:en', 05:27:34 INFO - 'LOGNAME': 'cltbld', 05:27:34 INFO - 'MAIL': '/var/mail/cltbld', 05:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:34 INFO - 'MOZ_NO_REMOTE': '1', 05:27:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:34 INFO - 'NO_EM_RESTART': '1', 05:27:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:34 INFO - 'PWD': '/builds/slave/test', 05:27:34 INFO - 'SHELL': '/bin/bash', 05:27:34 INFO - 'SHLVL': '1', 05:27:34 INFO - 'TERM': 'linux', 05:27:34 INFO - 'TMOUT': '86400', 05:27:34 INFO - 'USER': 'cltbld', 05:27:34 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467', 05:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:34 INFO - '_': '/tools/buildbot/bin/python'} 05:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:34 INFO - Running setup.py (path:/tmp/pip-X0_pWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:34 INFO - Running setup.py (path:/tmp/pip-1l8p5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:34 INFO - Running setup.py (path:/tmp/pip-HJEMiR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:34 INFO - Running setup.py (path:/tmp/pip-EhJ79G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:34 INFO - Running setup.py (path:/tmp/pip-BuIIQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:34 INFO - Running setup.py (path:/tmp/pip-vOZL9s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:34 INFO - Running setup.py (path:/tmp/pip-bTWPTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:34 INFO - Running setup.py (path:/tmp/pip-yaOBDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:35 INFO - Running setup.py (path:/tmp/pip-gMa2tX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:35 INFO - Running setup.py (path:/tmp/pip-mefORf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:35 INFO - Running setup.py (path:/tmp/pip-24MaLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:35 INFO - Running setup.py (path:/tmp/pip-l5BeQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:35 INFO - Running setup.py (path:/tmp/pip-mVEGRw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:35 INFO - Running setup.py (path:/tmp/pip-q97SIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:35 INFO - Running setup.py (path:/tmp/pip-yRqo87-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:35 INFO - Running setup.py (path:/tmp/pip-mgP1VK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:35 INFO - Running setup.py (path:/tmp/pip-VB6x_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:27:35 INFO - Running setup.py install for manifestparser 05:27:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:27:35 INFO - Running setup.py install for mozcrash 05:27:35 INFO - Running setup.py install for mozdebug 05:27:35 INFO - Running setup.py install for mozdevice 05:27:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:27:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:27:36 INFO - Running setup.py install for mozfile 05:27:36 INFO - Running setup.py install for mozhttpd 05:27:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:27:36 INFO - Running setup.py install for mozinfo 05:27:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:27:36 INFO - Running setup.py install for mozInstall 05:27:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:27:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:27:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:27:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:27:36 INFO - Running setup.py install for mozleak 05:27:36 INFO - Running setup.py install for mozlog 05:27:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:27:36 INFO - Running setup.py install for moznetwork 05:27:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:27:36 INFO - Running setup.py install for mozprocess 05:27:36 INFO - Running setup.py install for mozprofile 05:27:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:27:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:27:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:27:36 INFO - Running setup.py install for mozrunner 05:27:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:27:37 INFO - Running setup.py install for mozscreenshot 05:27:37 INFO - Running setup.py install for moztest 05:27:37 INFO - Running setup.py install for mozversion 05:27:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:27:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:27:37 INFO - Cleaning up... 05:27:37 INFO - Return code: 0 05:27:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:37 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')]} 05:27:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:37 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')]} 05:27:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:37 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 0x28661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b03b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b01290>, '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 0x2b01b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b02040>, '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': '0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467', '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 05:27:37 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 05:27:37 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 05:27:37 INFO - Using env: {'DISPLAY': ':0', 05:27:37 INFO - 'HOME': '/home/cltbld', 05:27:37 INFO - 'LANG': 'en_US.UTF-8', 05:27:37 INFO - 'LANGUAGE': 'en_US:en', 05:27:37 INFO - 'LOGNAME': 'cltbld', 05:27:37 INFO - 'MAIL': '/var/mail/cltbld', 05:27:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:37 INFO - 'MOZ_NO_REMOTE': '1', 05:27:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:37 INFO - 'NO_EM_RESTART': '1', 05:27:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:37 INFO - 'PWD': '/builds/slave/test', 05:27:37 INFO - 'SHELL': '/bin/bash', 05:27:37 INFO - 'SHLVL': '1', 05:27:37 INFO - 'TERM': 'linux', 05:27:37 INFO - 'TMOUT': '86400', 05:27:37 INFO - 'USER': 'cltbld', 05:27:37 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467', 05:27:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:37 INFO - '_': '/tools/buildbot/bin/python'} 05:27:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:27:37 INFO - Running setup.py (path:/tmp/pip-v4C0DU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:27:37 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)) 05:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:27:37 INFO - Running setup.py (path:/tmp/pip-vzoljU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:27:37 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)) 05:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:27:37 INFO - Running setup.py (path:/tmp/pip-Tq7HXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:27:37 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)) 05:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:27:37 INFO - Running setup.py (path:/tmp/pip-pKQfH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:27:37 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)) 05:27:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:27:37 INFO - Running setup.py (path:/tmp/pip-G_9XDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:27:38 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)) 05:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:27:38 INFO - Running setup.py (path:/tmp/pip-pUDnml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:27:38 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)) 05:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:27:38 INFO - Running setup.py (path:/tmp/pip-4yucXq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:27:38 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)) 05:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:27:38 INFO - Running setup.py (path:/tmp/pip-dEWVr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:27:38 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)) 05:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:27:38 INFO - Running setup.py (path:/tmp/pip-pSo7rn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:27:38 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)) 05:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:27:38 INFO - Running setup.py (path:/tmp/pip-T3_bsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:27:38 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)) 05:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:27:38 INFO - Running setup.py (path:/tmp/pip-PjLiFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:27:38 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)) 05:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:27:38 INFO - Running setup.py (path:/tmp/pip-ltVWZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:27:38 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)) 05:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:27:38 INFO - Running setup.py (path:/tmp/pip-3d99wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:27:38 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)) 05:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:27:38 INFO - Running setup.py (path:/tmp/pip-lO58tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:27:38 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)) 05:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:38 INFO - Running setup.py (path:/tmp/pip-h_0EwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:27:38 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)) 05:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:27:38 INFO - Running setup.py (path:/tmp/pip-GvpCSH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:27:38 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)) 05:27:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:27:38 INFO - Running setup.py (path:/tmp/pip-rvFmuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:27:38 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)) 05:27:38 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)) 05:27:38 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)) 05:27:38 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)) 05:27:38 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)) 05:27:38 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)) 05:27:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:27:38 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 05:27:38 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 05:27:38 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 05:27:38 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 05:27:38 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 05:27:38 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 05:27:40 INFO - Downloading blessings-1.6.tar.gz 05:27:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:27:41 INFO - Installing collected packages: blessings 05:27:41 INFO - Running setup.py install for blessings 05:27:41 INFO - Successfully installed blessings 05:27:41 INFO - Cleaning up... 05:27:41 INFO - Return code: 0 05:27:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:27:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:41 INFO - Reading from file tmpfile_stdout 05:27:41 INFO - Current package versions: 05:27:41 INFO - argparse == 1.2.1 05:27:41 INFO - blessings == 1.6 05:27:41 INFO - blobuploader == 1.2.4 05:27:41 INFO - docopt == 0.6.1 05:27:41 INFO - functools32 == 3.2.3-2 05:27:41 INFO - jsonschema == 2.5.1 05:27:41 INFO - manifestparser == 1.1 05:27:41 INFO - mozInstall == 1.12 05:27:41 INFO - mozcrash == 1.0 05:27:41 INFO - mozdebug == 0.1 05:27:41 INFO - mozdevice == 0.49 05:27:41 INFO - mozfile == 1.2 05:27:41 INFO - mozhttpd == 0.7 05:27:41 INFO - mozinfo == 0.9 05:27:41 INFO - mozleak == 0.1 05:27:41 INFO - mozlog == 3.4 05:27:41 INFO - moznetwork == 0.27 05:27:41 INFO - mozprocess == 0.25 05:27:41 INFO - mozprofile == 0.28 05:27:41 INFO - mozrunner == 6.13 05:27:41 INFO - mozscreenshot == 0.1 05:27:41 INFO - mozsystemmonitor == 0.3 05:27:41 INFO - moztest == 0.8 05:27:41 INFO - mozversion == 1.4 05:27:41 INFO - psutil == 3.1.1 05:27:41 INFO - requests == 1.2.3 05:27:41 INFO - wsgiref == 0.1.2 05:27:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:27:41 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')]} 05:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:41 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')]} 05:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:41 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 0x28661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b03b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b01290>, '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 0x2b01b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b02040>, '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': '0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467', '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 05:27:41 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 05:27:41 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 05:27:41 INFO - Using env: {'DISPLAY': ':0', 05:27:41 INFO - 'HOME': '/home/cltbld', 05:27:41 INFO - 'LANG': 'en_US.UTF-8', 05:27:41 INFO - 'LANGUAGE': 'en_US:en', 05:27:41 INFO - 'LOGNAME': 'cltbld', 05:27:41 INFO - 'MAIL': '/var/mail/cltbld', 05:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:41 INFO - 'MOZ_NO_REMOTE': '1', 05:27:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:41 INFO - 'NO_EM_RESTART': '1', 05:27:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:41 INFO - 'PWD': '/builds/slave/test', 05:27:41 INFO - 'SHELL': '/bin/bash', 05:27:41 INFO - 'SHLVL': '1', 05:27:41 INFO - 'TERM': 'linux', 05:27:41 INFO - 'TMOUT': '86400', 05:27:41 INFO - 'USER': 'cltbld', 05:27:41 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467', 05:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:41 INFO - '_': '/tools/buildbot/bin/python'} 05:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:41 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)) 05:27:41 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)) 05:27:41 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)) 05:27:41 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)) 05:27:41 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)) 05:27:41 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)) 05:27:41 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)) 05:27:41 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)) 05:27:41 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)) 05:27:41 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)) 05:27:41 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)) 05:27:41 INFO - Cleaning up... 05:27:41 INFO - Return code: 0 05:27:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:27:41 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')]} 05:27:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:27:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:41 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')]} 05:27:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:27:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:27:41 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 0x28661f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x295ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b03b10>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b01290>, '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 0x2b01b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b02040>, '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': '0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467', '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 05:27:41 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 05:27:41 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 05:27:41 INFO - Using env: {'DISPLAY': ':0', 05:27:41 INFO - 'HOME': '/home/cltbld', 05:27:41 INFO - 'LANG': 'en_US.UTF-8', 05:27:41 INFO - 'LANGUAGE': 'en_US:en', 05:27:41 INFO - 'LOGNAME': 'cltbld', 05:27:41 INFO - 'MAIL': '/var/mail/cltbld', 05:27:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:41 INFO - 'MOZ_NO_REMOTE': '1', 05:27:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:41 INFO - 'NO_EM_RESTART': '1', 05:27:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:41 INFO - 'PWD': '/builds/slave/test', 05:27:41 INFO - 'SHELL': '/bin/bash', 05:27:41 INFO - 'SHLVL': '1', 05:27:41 INFO - 'TERM': 'linux', 05:27:41 INFO - 'TMOUT': '86400', 05:27:41 INFO - 'USER': 'cltbld', 05:27:41 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467', 05:27:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:41 INFO - '_': '/tools/buildbot/bin/python'} 05:27:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:27:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:27:41 INFO - Cleaning up... 05:27:41 INFO - Return code: 0 05:27:41 INFO - Running post-action listener: _resource_record_post_action 05:27:41 INFO - Running post-action listener: _start_resource_monitoring 05:27:41 INFO - Starting resource monitoring. 05:27:41 INFO - [mozharness: 2017-03-15 12:27:41.904750Z] Finished create-virtualenv step (success) 05:27:41 INFO - [mozharness: 2017-03-15 12:27:41.905224Z] Running install step. 05:27:41 INFO - Running pre-action listener: _resource_record_pre_action 05:27:41 INFO - Running main action method: install 05:27:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:27:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:27:42 INFO - Reading from file tmpfile_stdout 05:27:42 INFO - Detecting whether we're running mozinstall >=1.0... 05:27:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:27:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:27:42 INFO - Reading from file tmpfile_stdout 05:27:42 INFO - Output received: 05:27:42 INFO - Usage: mozinstall [options] installer 05:27:42 INFO - Options: 05:27:42 INFO - -h, --help show this help message and exit 05:27:42 INFO - -d DEST, --destination=DEST 05:27:42 INFO - Directory to install application into. [default: 05:27:42 INFO - "/builds/slave/test"] 05:27:42 INFO - --app=APP Application being installed. [default: firefox] 05:27:42 INFO - mkdir: /builds/slave/test/build/application 05:27:42 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'] 05:27:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:27:57 INFO - Reading from file tmpfile_stdout 05:27:57 INFO - Output received: 05:27:57 INFO - /builds/slave/test/build/application/firefox/firefox 05:27:57 INFO - Running post-action listener: _resource_record_post_action 05:27:57 INFO - [mozharness: 2017-03-15 12:27:57.635443Z] Finished install step (success) 05:27:57 INFO - [mozharness: 2017-03-15 12:27:57.635715Z] Running run-tests step. 05:27:57 INFO - Running pre-action listener: _resource_record_pre_action 05:27:57 INFO - Running main action method: run_tests 05:27:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:27:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:27:57 INFO - Python 2.7.3 05:27:57 INFO - Return code: 0 05:27:57 INFO - grabbing minidump binary from tooltool 05:27:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:27:57 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 0x2b01290>, '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 0x2b01b90>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b02040>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:27:57 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 05:27:57 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 05:27:57 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 05:27:57 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:27:57 INFO - Return code: 0 05:27:57 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:27:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:27:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:27:57 INFO - ENV: RUST_BACKTRACE is now 1 05:27:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:27:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:27:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 05:27:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-058 --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 05:27:57 INFO - Using env: {'DISPLAY': ':0', 05:27:57 INFO - 'HOME': '/home/cltbld', 05:27:57 INFO - 'LANG': 'en_US.UTF-8', 05:27:57 INFO - 'LANGUAGE': 'en_US:en', 05:27:57 INFO - 'LOGNAME': 'cltbld', 05:27:57 INFO - 'MAIL': '/var/mail/cltbld', 05:27:57 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:27:57 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:27:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:27:57 INFO - 'MOZ_NO_REMOTE': '1', 05:27:57 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:27:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:27:57 INFO - 'NO_EM_RESTART': '1', 05:27:57 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:27:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:27:57 INFO - 'PWD': '/builds/slave/test', 05:27:57 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:27:57 INFO - 'RUST_BACKTRACE': '1', 05:27:57 INFO - 'SHELL': '/bin/bash', 05:27:57 INFO - 'SHLVL': '1', 05:27:57 INFO - 'TERM': 'linux', 05:27:57 INFO - 'TMOUT': '86400', 05:27:57 INFO - 'USER': 'cltbld', 05:27:57 INFO - 'XDG_SESSION_COOKIE': '0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467', 05:27:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:27:57 INFO - '_': '/tools/buildbot/bin/python'} 05:27:57 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-058', '--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 05:27:57 INFO - mozversion application_buildid: 20170315120105 05:27:57 INFO - mozversion application_changeset: 0cc9dced786cf2a3baeff707b636b4ad02637df0 05:27:57 INFO - mozversion application_display_name: Nightly 05:27:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:27:57 INFO - mozversion application_name: Firefox 05:27:57 INFO - mozversion application_remotingname: firefox 05:27:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:27:57 INFO - mozversion application_vendor: Mozilla 05:27:57 INFO - mozversion application_version: 55.0a1 05:27:57 INFO - mozversion platform_buildid: 20170315120105 05:27:57 INFO - mozversion platform_changeset: 0cc9dced786cf2a3baeff707b636b4ad02637df0 05:27:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:27:57 INFO - mozversion platform_version: 55.0a1 05:27:57 INFO - using testdate: 1489580877 05:27:57 INFO - actual date: 1489580877 05:27:57 INFO - starting webserver on 'localhost:44325' 05:27:57 INFO - SUITE-START | Running 2 tests 05:27:57 INFO - TEST-START | dromaeo_css 05:27:57 INFO - operating with platform_type : linux_ 05:27:57 INFO - Initialising browser for dromaeo_css test... 05:27:57 INFO - TEST-INFO | started process 21523 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpctSrdN/profile http://localhost:44325/getInfo.html) 05:28:01 INFO - PID 21523 | __metrics Screen width/height:1600/1200 05:28:01 INFO - PID 21523 | colorDepth:24 05:28:01 INFO - PID 21523 | Browser inner width/height: 1024/697 05:28:01 INFO - PID 21523 | __metrics 05:28:02 INFO - PID 21523 | 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" 05:28:02 INFO - PID 21523 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:28:03 INFO - TEST-INFO | 21523: exit 0 05:28:03 INFO - Browser initialized. 05:28:03 INFO - Running cycle 1/1 for dromaeo_css test... 05:28:03 INFO - TEST-INFO | started process 21615 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpctSrdN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:28:16 INFO - PID 21615 | RSS: Main: 152018944 05:28:16 INFO - PID 21615 | 05:31:21 INFO - PID 21615 | Cycle 1(1): loaded http://localhost:44325/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44325/tests/dromaeo/cssquery-ext.html) 05:31:23 INFO - PID 21615 | RSS: Main: 323940352 05:31:23 INFO - PID 21615 | 05:33:05 INFO - PID 21615 | ************************* 05:33:05 INFO - PID 21615 | A coding exception was thrown and uncaught in a Task. 05:33:05 INFO - PID 21615 | 05:33:05 ERROR - PID 21615 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:33:05 INFO - PID 21615 | Full stack: 05:33:05 INFO - PID 21615 | ************************* 05:34:26 INFO - PID 21615 | Cycle 1(1): loaded http://localhost:44325/tests/dromaeo/cssquery-ext.html (next: http://localhost:44325/tests/dromaeo/cssquery-jquery.html) 05:34:27 INFO - PID 21615 | RSS: Main: 235974656 05:34:27 INFO - PID 21615 | 05:37:29 INFO - PID 21615 | Cycle 1(1): loaded http://localhost:44325/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44325/tests/dromaeo/cssquery-mootools.html) 05:37:30 INFO - PID 21615 | RSS: Main: 217989120 05:37:30 INFO - PID 21615 | 05:40:32 INFO - PID 21615 | Cycle 1(1): loaded http://localhost:44325/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44325/tests/dromaeo/cssquery-prototype.html) 05:40:32 INFO - PID 21615 | RSS: Main: 227008512 05:40:32 INFO - PID 21615 | 05:43:36 INFO - PID 21615 | Cycle 1(1): loaded http://localhost:44325/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44325/tests/dromaeo/cssquery-yui.html) 05:43:36 INFO - PID 21615 | RSS: Main: 189452288 05:43:36 INFO - PID 21615 | 05:46:39 INFO - PID 21615 | Cycle 1(1): loaded http://localhost:44325/tests/dromaeo/cssquery-yui.html (next: http://localhost:44325/tests/dromaeo/cssquery-dojo.html) 05:46:40 INFO - PID 21615 | RSS: Main: 267046912 05:46:40 INFO - PID 21615 | 05:46:40 INFO - PID 21615 | __start_tp_report 05:46:40 INFO - PID 21615 | _x_x_mozilla_page_load 05:46:40 INFO - PID 21615 | _x_x_mozilla_page_load_details 05:46:40 INFO - PID 21615 | |i|pagename|runs| 05:46:40 INFO - PID 21615 | |0;dojo.html;2601.271643939697;2645.140329392948;2669.7330266973304;2670.279024663341;2672.0247109804927;4834.975825120879;4924.433690125627;4930.876728081796;4941.9011619767625;4992.825251116212;4886.853394398165;4938.629602779788;4939.58013568847;4984.327115839361;4987.202047672373;4461.464624245095;4480.238359478896;4509.030558429937;4569.954300457002;4588.449386073659;4581.266997280436;4601.309803529464;4614.792334344946;4620.97689511552;4664.323673067403;4400.4939431965095;4454.2873140297725;4456.9331460028125;4552.317152427129;4555.817767289304;4524.954750452486;4558.339040839093;4569.29175977724;4610.05493873755;4614.192516309632;4503.1218912312115;4521.434820647419;4529.026259354222;4544.613707834838;4580.473245576734;4820.951790482085;4957.950420495785;4964.90070198594;4975.4029516457895;4986.900261994776;5262.552683021948;5285.233641122016;5287.47125287472;5288.0745869472685;5290.365156181283;5290.338707661543;5301.019311427398;5318.175682769177;5358.97320513395;5405.297311349499;5021.196608542616;5025.296458495814;5026.145555255615;5030.37120359955;5043.167877300204;5433.809816656398;5495.642783219078;5499.1476321170285;5503.3120859892515;5530.474604912527;5100.6429549931145;5148.099082660519;5148.2020286855595;5150.665206761623;5170.689758614495;5208.192730126836;5267.473252674778;5270.5256526912;5272.525472707474;5273.472652734696;5256;5273.31446911899;5275.3142091528625;5276.129438642581;5286.154215325606;5237.921431178535;5267.183586544092;5317.255584218213;5319.867003324948;5324.094903866352;4482.058767658763;4501.572350626685;4503.121891231244;4504.166729155117;4548.1813273610405;3810.7713537187856;3890.90272743178;3899.532056153223;3932.05630648648;3996.9200615987515;4479.776011199492;4545.772711364419;4566.315052742115;4580.358749775034;4581.541845815392;5315.973420132875;5322.441143679858;5359.812406565751;5365.517103460707;5372.033034053829;4543;4544.795484203219;4545.749983750859;4547.272436410159;4590.563896429834;4618.445786505641;4686.461056978491;4750.691205071659;4755.857324280277;4809.855704328876;4922.655414120977;4934.457209706858;4969.031038947371;4974.37820272466;4986.9251961221335;5329.626926115135;5331.5201631853315;5346.812861549827;5347.278117454094;5437.157240627709;4893.339399181065;5016.774245158904;5017;5020.523050310215;5021.924671129863;5147.5881929446305;5235.476452354734;5294.708791016531;5306.8407947761625;5311.49540793624;5341.225522299323;5343.9465605345;5344.572434205176;5346.492083252085;5351.331083614548;5140.897182056413;5193.11717008102;5196.636235463481;5202.73986300691;5252.5535329497425;5000.699958002531;5025.095482813129;5134.12719837636;5168.121419358643;5193.974030129825;5119.0529751996;5123.129068058364;5127.692338459704;5128.410232823124;5151.974240128776;5025.47232540578;5093.7707803148205;5095.566876815512;5099.235114732672;5223.843284701465;5006.949930500648;5008.974955125201;5018.874528136826;5018.974905125451;5020.071286811952 05:46:40 INFO - PID 21615 | |1;ext.html;691.9757808476703;714.0538786108406;775.0815283888593;787.7046107709613;789.1910791438771;31959.36081278373;32824.835875820616;32929.83535082324;33028.83485582575;33059.83470082652;33221.33557328858;33697;33883.15292117698;33920.49119263207;33922.49116263258;6696.933030669679;6884.380405763481;7378.667959941802;7539;7546;8898.332625053115;9097.499637519933;9113.681021164228;9115.863262051074;9116.58975346111;9243.584038718274;9308.488033158173;9311.115444032806;9335.159835614793;9335.579898904565;9409.294302927274;9490.288228382899;9505.42967421957;9509;9510.239180865514;9301.441913485212;9341.953290233574;9381.390209636353;9383.108604682544;9391.201747851372;34243.82878085619;34416.13959651004;34492.82753586241;34511.654883451345;34534;3173.220630882973;3211.373782112489;3217.871285148591;3247.4804031355106;3292.720118789906;23627.527449450914;24038.75961240383;24171.758282417304;24288.757112429004;24818.5036299273;3167.857446414917;3177.4121787469394;3204.150900011499;3241.205904553376;3351.145457908218;159505;159603;159943;160031.99999999884;160369;32787.67212327894;33162;36790.44814327787;43270.13459730788;43494;39464.60535394667;39508.802455987534;39530.60469395327;39690.60309396869;39724.40413393801;11265.324080555192;11390;11401.828972565418;11409.42952852354;11411.258268212705;8935.955320223356;8937.776555586162;8940.3741738079;8951.41815781972;8963.193312601898;12682.936585317015;12685.936570317273;12696.6825829355;12700.618981430573;12760.489580416865;5222.216667499905;5243.344581927259;5259.552938000313;5301.602379821529;5346;1024.5594394410475;1046.0585473074293;1047.3899399087197;1050.3592808386877;1066.706655669697;22482.100715971177;22559.774402255767;22683.319500415015;22725.204617838626;22828.65757013646;1072.383379556758;1099.8295264234057;1110.6945589962825;1117.871444783844;1132.9773404531863;11257.380844053656;12186.878131218751;12202.14584979043;12205;12211.26732396059;202878;203018;203070;203279;203718;41179.7941010293;41215.1756964859;41794.79102604467;41872.37191442131;41907.79046104811;1187.31401409998;1225.4791713521895;1235.2588446931768;1241.7392347606742;1244.520859469111;20309.49226269355;20373.69439458439;21276;21913.890430548385;23366.53266934686;35595;35678.464823027156;36829.63170368369;36894.262114758094;36916.261674766894;168591;168812;168870;169125;169423.1528842348;22363;22715;22823.657645135005;25887.611685825104;28249.15252542427;31074.22314442157;31163.37673246477;31350.216244594067;31593.8420307897;31676.5248521277;26374.20877373682;26822.463550729266;26904.461910762067;27061.323466913484;27132.32169195707;26857.86571067132;27140.592891106255;28093.438131237668;28157;28708.85645571759;29006.46139119407;29229.707702923548;29281;31178.22054448657;31509.951853129474;25656.501059195518;27990.860045700454;28002.159935201977;28264.434711305246;28391.148265552067;21967;22032.669509957042;22043.889780550995;22075.33773986783;22328.441788955406 05:46:40 INFO - PID 21615 | |2;jquery.html;361.6925613228754;386.2603115034707;416.3338658146964;418.0072328220476;420.7832966022499;11902.006551203343;13270.933645331772;13376.264305463195;17818;18040.18819153138;16907.323707051703;17132.229049692764;17304.221310041048;17435.389761358354;17461.1269436528;5391.514763671269;5646.887062258752;5649.406812284713;5661.122526008455;5753.971230143843;5737.282839645044;5839.32847722511;6596.109525214083;6861.941417574732;6897.137857767779;6817.795466136024;6864.862702745942;6879.3120687931305;6883.724651013953;6885.655717214145;6748.325167483237;6875.278095799919;6889.931100688979;6902.482313826483;6902.551334163263;6671.332866713338;6721.663916804189;6729.899051514182;6810.387065164109;6896.344847239504;21162.365129046153;21469.463263418384;21905.561888762135;22537.887310563507;22766.31701048971;2368.3723813189517;2397.2568503763714;2414.0705828256073;2419.0807493152665;2470.258922323296;13904.513342033082;13909.026368154233;14128.788068178985;14306.785398219035;14866;1894.914728837192;1901.1558389796621;1907.5517253445569;1940.5827747034455;1972.7336809530673;84851;85547.57226213829;86358.56820715919;87303;90631.54684226536;16171.676566468605;16432.671346573003;16602.418915337905;16770.58073548171;16998;29524.852375737984;29539.556906646416;29556.408871822445;29642.703572964427;29739.10782676523;8415.34574772887;8517.209841620543;8591.410589041048;8841.336899732545;8912.242459390895;6957.617331046841;7040.436765058783;7165.713371465187;7220.927790722026;7240.4569657275915;8863.309352517985;9082.273418126533;9143.988322569025;9199.816003679889;9358.298127640319;3543.7696549724187;3574.57105147384;3672.9632703673155;3708.8145592720257;3745.2135051638916;948.5494390164616;962.8363178259573;987.9555420006117;998.8851282102506;1051.3534176481562;17318.913405432893;17901.552461188574;18438.723419148722;20570.88865682039;21883.10591228489;878.8286284174652;889.3374436045059;897.699270744308;908.6728777640044;913.8172365526921;9851.605935762489;10897.400642964554;10913;10915;10923.945380273048;464827;466120;471049;531885;533012;75313.62343188249;85661;85843.57078214694;87518.56240718755;87724.12275877288;1070.7055559721139;1124.3085502415956;1135.0125390909961;1143.5311522275993;1145.0667705819565;16195.59511012187;16257.26842292076;16617.41839035628;16976.74534881953;17113.14434278306;35868.820655897594;37788.81105594454;41765;42282.78858605687;44434;52844.20733688921;52967.47032529626;53007;53559.46440535545;55390.169147463625;10122.544485498023;10229.488525573543;10843.132549395872;10851.45742712877;11352.943235284101;11537.250078744855;12260.080493963167;12347.13570050088;12858.292793896426;12890.226586404846;10223.386596804216;10351.585936562453;10497.212709047004;11090.778184436427;11328.263662862217;10749.623763168564;11297.943510282395;11335.206535542433;11418.657440276806;11479.36863472517;10436.425996570262;10753.139748820233;11488.138389620644;11786.882131178578;11925.82111268349;10147.949260253652;10218.744531386776;10228.386296822215;10251.58993640246;10651.573937042742;11069.391183484664;11151.330920144817;11222.831657524981;11480.712982175512;11721.648350549498 05:46:40 INFO - PID 21615 | |3;mootools.html;1294.7539967406199;1478.7560052591323;1480.570634515991;1509.2001239343144;1519.5686900958467;7949.24482174194;8803.383763136575;9234.538273086344;9354.579043943022;9355.391899526527;9291.767705807359;9466.100720431548;9487.38332008419;9494.572744226509;9504.76238094048;1720.0625659015805;2046.447459186019;2093.9581208375826;2102.7686954435;2104.231955336299;1769.9380521681744;2050.764162121353;2111.134434881699;2112.4824418017606;2125.341144245281;2042.6425375559293;2056.4139220322213;2064.1330641130685;2064.61804566155;2074.813266805987;1950.5221220800852;1973.4572992427054;1984.5137941204353;1988.443235893952;1999.7700264469481;1915.990420047891;1961.7743959444704;1968.2422267427;1980.7524059492564;1991.71120187572;9390.906090939072;9471.242300615933;9472.763180920463;9496.952515237448;9521.761955951088;4489.865304040884;4629.305604159369;4641.257398816173;4642.814287428499;4651.279051746985;2427.174760581393;2675.4782817350624;2719.075514325139;2727.686316073657;2731.1533424638424;972.0813830929774;1020.4948550467492;1021.0300214795974;1031.1853635627845;1054.6256079091966;13186.07697461178;13358.131721438172;13409.731805363936;13432.126911750802;13462.865371346259;3809.6190380962234;3942.1721438498234;4032.495938007749;4035.596440355941;4162.980954237192;11858.703532411586;11877.990370818405;11879.109066820023;11898.881011189951;11908.106891983136;4700.388949436619;4701.200795864711;4714.528547145258;4717.764111794397;4722.905541889212;3497.4753786932165;3514.4903988921465;4153.314703073959;4303.74177549348;4308.482982042112;3624.383854744647;3708.38811596089;3725.1618385863508;3790.9241815164096;3794.772313661189;1044.1646682653848;1045.383223897904;1046.1055797293357;1063.8244689626124;1073.3184427888348;748.8165399477163;750.2122771090334;762.7635433015782;771.6103367799337;782.4210084537515;5812.796552120655;5907.881842363128;5986.2517185351835;6004.789832355847;6152.384761523812;892.6340200517886;901.4906577783531;902.9051949545335;908.6910450446748;929.2612373163352;3719.8512059517316;3758.755680880734;3783;3793.6585707286476;3828.5979972102527;10866.891331086588;11292.717682058013;11300.321980681185;11301.20891537601;11321.207515473838;11004.064654504296;11147.554097835995;11161;11172.776544469065;11175;8291.461055031403;8368.83262334762;8439.282660973764;8596.398252122292;8603.569821509025;5971.552133590085;6149.96925015372;6192.845178870384;6238.282597501164;6244.968775156095;10706.571737130427;10921.071708904832;10976.725581860517;10984.395858227874;11017.394043327373;11318.434078295888;11405;11571.421428928352;11577.536898523964;11578.594749183738;6461.0954466373805;6746.257911629815;7287;7342.265773422615;7437.888431673421;8605.483670979762;8606.741797746077;8706.738797836075;8708.956455217936;8712.69505567302;7301.853962920818;7312.305330993547;7324.926750732638;7536.585487798005;7689.154193038873;7245.855082898418;7577.204393538819;7597.430192735677;7611.847763044598;7623.809404764926;6833.145856767904;7024.719011239493;7030.789076327718;7032.331928466788;7033.226345101933;5258.368995720385;5301.920471193012;5397.082495975615;5409.945900540944;5495.368032676133;5330.360356757059;5335.199720042025;5366.302380690485;5416.620836541404;5504.9174262385295 05:46:40 INFO - PID 21615 | |4;prototype.html;360.62134758503566;364.73921146380343;376.4898562447883;377.1062581681414;382.10396619926263;5173.5425672805495;5175.8188463403785;5214.374275086985;5217.634765566407;5223.138182199932;4822.252550854614;4939.950600493994;4972.651914365996;5012.899742005157;5088.720120393377;4234.30134027885;4245.469316335458;4246.150769846027;4251.0860165064505;4258.829646814139;4231.4710661167355;4242.087951090515;4256.659467242614;4262.6589872810255;4267.445232119836;4036.919261614766;4182.958170418303;4247.660187185018;4248.936265956013;4255.234057869582;4206.600372964579;4208.768517731508;4211.957880421218;4218.557051509578;4222.936655950163;3914.1388894443176;3921.627445392683;3930.5479869815053;3931.9213615727813;3934.8229329680235;4831.396075490564;4952.678075925053;4962.1812400953795;4973.452920178777;4978.033676697684;4882.804687812483;4897.853064408074;4902.705837649717;4907.4356449008465;4907.8773030674165;5347.064263753828;5347.518723314882;5354.063038968165;5365.409804921455;5395.892082158335;4207.326827707552;4300.397944287803;4307;4329.675274354436;4338.240807858612;5286.524212820865;5460.481254280837;5510.586705997026;5555.8888822223325;5657.915131273035;4465.732056076646;4482.775861206992;4486.371907932892;4486.439195100613;4489.169503641837;4538.750368729686;4551.7724113794175;4552.203364411214;4558.863234102916;4560.674056231346;4542.636589072867;4607.193741095295;4881.682690625098;4893.804247830119;4912.1158191525155;5329.81345652908;5342.545883599938;5358.223057656696;5359.892802143935;5361.249425080492;1567.4670611991978;1572.5518227305163;1579.1472604793282;1581.5176371206662;1588.7378582533984;1152.5159433038143;1183.402381797187;1195.3425615911215;1200.7778560966249;1217.9343074809542;4706.1528924793865;4706.952930470651;4707;4714.929276060861;4715.292706094045;5538.944610553843;5543.1408131739645;5543.556515478752;5547.834954659486;5548.445155484419;4601.309803529497;4658.440987081572;4696.8121275148615;4698.201305778026;4725.125851717443;2895.885084242582;2932.72139146785;2942.558616207586;2945.175350901751;2945.4256419998324;5183.45573714762;5185.954955135001;5186.455422180617;5194.22086687;5208.463503266546;5438.857839853596;5605.934872374236;5626.915596266059;5630.352509461382;5650.378458369576;5107.5994282687825;5146.639735218499;5151.896962060738;5182.455842136596;5215.739213039409;5341.4925582069645;5424.511793938565;5509.586780991362;5516.586256030894;5533.972330138324;5389.299391079135;5391.137418013099;5398.919016214839;5412.891742165056;5458.317710286215;4966.776495057658;5095.872603184802;5118.436971933159;5138.177891537336;5163.4578369270685;4218.346156345771;4311.5903989122235;4330.41539392178;4335.80488877995;4439.112177564564;5487.451254874481;5500.972495137658;5504.9174262385295;5505.119180931032;5509.889802204014;5218.060749065205;5329.3604767426605;5338.572914166935;5357.78568857257;5370.549951513148;5327.866803329948;5340.49265319794;5351.1973204019705;5367.490088441592;5367.704776237344;5064.392272927125;5258.263843062051;5272.2882410874045;5288.709120998382;5294.682319060868;5336.519713225673;5347.705876176848;5363.597730170331;5374.489423504917;5379.67721936685;5209.817656382009;5219.373675159005;5238.109521381298;5240.624078894014;5250.159974404077 05:46:40 INFO - PID 21615 | |5;yui.html;589.1339730596022;593.6705128653597;602.6504627316156;605.751641826851;632.5256057956533;12044.277343359394;12262.325572093532;12404.379781010946;12727.236365818057;13256.668583285398;12617.747645047093;13008.219506829597;13021.414036368362;13030.73938521229;13040;633.5185259202992;647.1522305779421;824.8680211166214;828.2090603473698;852.3862818770475;850.9021462531795;852.0797538658235;852.7313896122732;853.1937319233327;853.6201390381283;895.7536677413731;904.5567671840784;904.606496174163;905.7237542549519;906.6282824042144;897.6499165325529;898.6854600889702;898.8966268879065;899.1727610598233;900.3652425040331;658.799066284783;659.3176062775053;660.3132741948368;660.6597602234853;661.1702313596405;11525.942370288094;11550.826737598944;11565.248258863232;11725.70685732855;13412.329383530785;11911.702207444883;12451.190672606343;12755.06908664522;13149.671258218525;13208.73582528344;12236.204646697935;12242.632721018384;12301.507939682402;12454.626361209179;12507.437165327583;4109.691773116998;4142.150859073882;4208.116295577902;4223.408722778813;4375.890602734925;58967;59739.40260597382;60511.48721281959;60731.69634151801;60823.391766082656;10671.573137074585;10723.517441715141;10751.139908807276;10808.29746066519;10976.12191024716;20313.289034884005;20349.59300814005;20361.592768144554;20473.590528189354;20632.58734825325;6150.753969841246;6436.3241859605005;6495.610263384212;6577.177852768404;6691.197056353269;3261.575995120619;3344.2642618623863;3344.6655334466845;3397.3375191837354;3406.6395014381633;2741.5476446386124;2778.305423644089;2799.8740056697497;2809.3819359741233;2815.2258129014276;486.9440014398319;494.5894907226993;495.49212057641205;498.47162008271346;499.7176595223687;580.89834279001;593.9020061689773;596.6181643748005;605.5942518512608;605.893968555501;8343.833262780521;8637.395382323302;8684.261837743863;9088.227500662519;9242.306826988002;498;502.8818227716484;504.6921377959442;511.93344865168035;514.0951924612634;4228.386883901879;4266.189424009491;4353.499347575006;4408.515063343029;4461.977690111528;58255.41744582585;61202.69398652978;62731.686341568915;62920.370796292365;63157.684211579566;53088;53392;53614.46385536095;54151.45848541543;55617.72191139018;48647.75676121597;49449;50090;50392.24411633828;50709.23936140961;7879.330256927996;8010.359171266401;8403.243708066304;8547.230749232598;8596.140385961355;34381;34773.13067173341;34881.65118348784;35176;35827.462588061724;40514.59485405226;41307.38038929358;42017.78991105025;42134.36798448087;42744.572554275306;9924.255680824112;9980.201583873419;9996;10134.442605656759;10215.13171380441;10842.78314433691;11116.777664446827;11238;11791.233569817934;11884.702882428008;10248.436336001592;10504.737381565523;10662.73343166427;10672.359658420519;10769.730756731144;10006.69979900604;10098.293119481566;10326.173906087344;10567.735806604589;10706.089982351275;10329.9483502582;10712.946435267773;10754.946225268823;10855;11062.944685276521;8404.789880253042;8448.197421244971;8717.869231961398;8722.302215822845;8765.912340876765;7878.212178782076;8124.796880078045;8251.860172671844;8541.316694664287;9921.51798132321 05:46:40 INFO - PID 21615 | __end_tp_report 05:46:40 INFO - PID 21615 | __start_cc_report 05:46:40 INFO - PID 21615 | _x_x_mozilla_cycle_collect,2396 05:46:40 INFO - PID 21615 | __end_cc_report 05:46:40 INFO - PID 21615 | __startTimestamp1489582000200__endTimestamp 05:46:40 INFO - PID 21615 | 05:46:40 INFO - PID 21615 | ------- Summary: start ------- 05:46:40 INFO - PID 21615 | Number of tests: 6 05:46:40 INFO - PID 21615 | 05:46:40 INFO - PID 21615 | [#0] dojo.html Cycles:165 Average:4889.86 Median:5018.97 stddev:533.41 (10.6%) stddev-sans-first:503.93 05:46:40 INFO - PID 21615 | Values: 2601.3 2645.1 2669.7 2670.3 2672.0 4835.0 4924.4 4930.9 4941.9 4992.8 4886.9 4938.6 4939.6 4984.3 4987.2 4461.5 4480.2 4509.0 4570.0 4588.4 4581.3 4601.3 4614.8 4621.0 4664.3 4400.5 4454.3 4456.9 4552.3 4555.8 4525.0 4558.3 4569.3 4610.1 4614.2 4503.1 4521.4 4529.0 4544.6 4580.5 4821.0 4958.0 4964.9 4975.4 4986.9 5262.6 5285.2 5287.5 5288.1 5290.4 5290.3 5301.0 5318.2 5359.0 5405.3 5021.2 5025.3 5026.1 5030.4 5043.2 5433.8 5495.6 5499.1 5503.3 5530.5 5100.6 5148.1 5148.2 5150.7 5170.7 5208.2 5267.5 5270.5 5272.5 5273.5 5256.0 5273.3 5275.3 5276.1 5286.2 5237.9 5267.2 5317.3 5319.9 5324.1 4482.1 4501.6 4503.1 4504.2 4548.2 3810.8 3890.9 3899.5 3932.1 3996.9 4479.8 4545.8 4566.3 4580.4 4581.5 5316.0 5322.4 5359.8 5365.5 5372.0 4543.0 4544.8 4545.7 4547.3 4590.6 4618.4 4686.5 4750.7 4755.9 4809.9 4922.7 4934.5 4969.0 4974.4 4986.9 5329.6 5331.5 5346.8 5347.3 5437.2 4893.3 5016.8 5017.0 5020.5 5021.9 5147.6 5235.5 5294.7 5306.8 5311.5 5341.2 5343.9 5344.6 5346.5 5351.3 5140.9 5193.1 5196.6 5202.7 5252.6 5000.7 5025.1 5134.1 5168.1 5194.0 5119.1 5123.1 5127.7 5128.4 5152.0 5025.5 5093.8 5095.6 5099.2 5223.8 5006.9 5009.0 5018.9 5019.0 5020.1 05:46:40 INFO - PID 21615 | 05:46:40 INFO - PID 21615 | [#1] ext.html Cycles:180 Average:32007.88 Median:31264.22 stddev:46002.21 (147.1%) stddev-sans-first:46071.16 05:46:40 INFO - PID 21615 | Values: 692.0 714.1 775.1 787.7 789.2 31959.4 32824.8 32929.8 33028.8 33059.8 33221.3 33697.0 33883.2 33920.5 33922.5 6696.9 6884.4 7378.7 7539.0 7546.0 8898.3 9097.5 9113.7 9115.9 9116.6 9243.6 9308.5 9311.1 9335.2 9335.6 9409.3 9490.3 9505.4 9509.0 9510.2 9301.4 9342.0 9381.4 9383.1 9391.2 34243.8 34416.1 34492.8 34511.7 34534.0 3173.2 3211.4 3217.9 3247.5 3292.7 23627.5 24038.8 24171.8 24288.8 24818.5 3167.9 3177.4 3204.2 3241.2 3351.1 159505.0 159603.0 159943.0 160032.0 160369.0 32787.7 33162.0 36790.4 43270.1 43494.0 39464.6 39508.8 39530.6 39690.6 39724.4 11265.3 11390.0 11401.8 11409.4 11411.3 8936.0 8937.8 8940.4 8951.4 8963.2 12682.9 12685.9 12696.7 12700.6 12760.5 5222.2 5243.3 5259.6 5301.6 5346.0 1024.6 1046.1 1047.4 1050.4 1066.7 22482.1 22559.8 22683.3 22725.2 22828.7 1072.4 1099.8 1110.7 1117.9 1133.0 11257.4 12186.9 12202.1 12205.0 12211.3 202878.0 203018.0 203070.0 203279.0 203718.0 41179.8 41215.2 41794.8 41872.4 41907.8 1187.3 1225.5 1235.3 1241.7 1244.5 20309.5 20373.7 21276.0 21913.9 23366.5 35595.0 35678.5 36829.6 36894.3 36916.3 168591.0 168812.0 168870.0 169125.0 169423.2 22363.0 22715.0 22823.7 25887.6 28249.2 31074.2 31163.4 31350.2 31593.8 31676.5 26374.2 26822.5 26904.5 27061.3 27132.3 26857.9 27140.6 28093.4 28157.0 28708.9 29006.5 29229.7 29281.0 31178.2 31510.0 25656.5 27990.9 28002.2 28264.4 28391.1 21967.0 22032.7 22043.9 22075.3 22328.4 05:46:40 INFO - PID 21615 | 05:46:40 INFO - PID 21615 | [#2] jquery.html Cycles:180 Average:29625.36 Median:29532.20 stddev:81281.03 (275.2%) stddev-sans-first:81479.35 05:46:40 INFO - PID 21615 | Values: 361.7 386.3 416.3 418.0 420.8 11902.0 13270.9 13376.3 17818.0 18040.2 16907.3 17132.2 17304.2 17435.4 17461.1 5391.5 5646.9 5649.4 5661.1 5754.0 5737.3 5839.3 6596.1 6861.9 6897.1 6817.8 6864.9 6879.3 6883.7 6885.7 6748.3 6875.3 6889.9 6902.5 6902.6 6671.3 6721.7 6729.9 6810.4 6896.3 21162.4 21469.5 21905.6 22537.9 22766.3 2368.4 2397.3 2414.1 2419.1 2470.3 13904.5 13909.0 14128.8 14306.8 14866.0 1894.9 1901.2 1907.6 1940.6 1972.7 84851.0 85547.6 86358.6 87303.0 90631.5 16171.7 16432.7 16602.4 16770.6 16998.0 29524.9 29539.6 29556.4 29642.7 29739.1 8415.3 8517.2 8591.4 8841.3 8912.2 6957.6 7040.4 7165.7 7220.9 7240.5 8863.3 9082.3 9144.0 9199.8 9358.3 3543.8 3574.6 3673.0 3708.8 3745.2 948.5 962.8 988.0 998.9 1051.4 17318.9 17901.6 18438.7 20570.9 21883.1 878.8 889.3 897.7 908.7 913.8 9851.6 10897.4 10913.0 10915.0 10923.9 464827.0 466120.0 471049.0 531885.0 533012.0 75313.6 85661.0 85843.6 87518.6 87724.1 1070.7 1124.3 1135.0 1143.5 1145.1 16195.6 16257.3 16617.4 16976.7 17113.1 35868.8 37788.8 41765.0 42282.8 44434.0 52844.2 52967.5 53007.0 53559.5 55390.2 10122.5 10229.5 10843.1 10851.5 11352.9 11537.3 12260.1 12347.1 12858.3 12890.2 10223.4 10351.6 10497.2 11090.8 11328.3 10749.6 11297.9 11335.2 11418.7 11479.4 10436.4 10753.1 11488.1 11786.9 11925.8 10147.9 10218.7 10228.4 10251.6 10651.6 11069.4 11151.3 11222.8 11480.7 11721.6 05:46:40 INFO - PID 21615 | 05:46:40 INFO - PID 21615 | [#3] mootools.html Cycles:180 Average:5822.08 Median:4158.15 stddev:3682.64 (88.6%) stddev-sans-first:3677.26 05:46:40 INFO - PID 21615 | Values: 1294.8 1478.8 1480.6 1509.2 1519.6 7949.2 8803.4 9234.5 9354.6 9355.4 9291.8 9466.1 9487.4 9494.6 9504.8 1720.1 2046.4 2094.0 2102.8 2104.2 1769.9 2050.8 2111.1 2112.5 2125.3 2042.6 2056.4 2064.1 2064.6 2074.8 1950.5 1973.5 1984.5 1988.4 1999.8 1916.0 1961.8 1968.2 1980.8 1991.7 9390.9 9471.2 9472.8 9497.0 9521.8 4489.9 4629.3 4641.3 4642.8 4651.3 2427.2 2675.5 2719.1 2727.7 2731.2 972.1 1020.5 1021.0 1031.2 1054.6 13186.1 13358.1 13409.7 13432.1 13462.9 3809.6 3942.2 4032.5 4035.6 4163.0 11858.7 11878.0 11879.1 11898.9 11908.1 4700.4 4701.2 4714.5 4717.8 4722.9 3497.5 3514.5 4153.3 4303.7 4308.5 3624.4 3708.4 3725.2 3790.9 3794.8 1044.2 1045.4 1046.1 1063.8 1073.3 748.8 750.2 762.8 771.6 782.4 5812.8 5907.9 5986.3 6004.8 6152.4 892.6 901.5 902.9 908.7 929.3 3719.9 3758.8 3783.0 3793.7 3828.6 10866.9 11292.7 11300.3 11301.2 11321.2 11004.1 11147.6 11161.0 11172.8 11175.0 8291.5 8368.8 8439.3 8596.4 8603.6 5971.6 6150.0 6192.8 6238.3 6245.0 10706.6 10921.1 10976.7 10984.4 11017.4 11318.4 11405.0 11571.4 11577.5 11578.6 6461.1 6746.3 7287.0 7342.3 7437.9 8605.5 8606.7 8706.7 8709.0 8712.7 7301.9 7312.3 7324.9 7536.6 7689.2 7245.9 7577.2 7597.4 7611.8 7623.8 6833.1 7024.7 7030.8 7032.3 7033.2 5258.4 5301.9 5397.1 5409.9 5495.4 5330.4 5335.2 5366.3 5416.6 5504.9 05:46:40 INFO - PID 21615 | 05:46:40 INFO - PID 21615 | [#4] prototype.html Cycles:180 Average:4566.52 Median:4969.71 stddev:1214.79 (24.4%) stddev-sans-first:1176.46 05:46:40 INFO - PID 21615 | Values: 360.6 364.7 376.5 377.1 382.1 5173.5 5175.8 5214.4 5217.6 5223.1 4822.3 4940.0 4972.7 5012.9 5088.7 4234.3 4245.5 4246.2 4251.1 4258.8 4231.5 4242.1 4256.7 4262.7 4267.4 4036.9 4183.0 4247.7 4248.9 4255.2 4206.6 4208.8 4212.0 4218.6 4222.9 3914.1 3921.6 3930.5 3931.9 3934.8 4831.4 4952.7 4962.2 4973.5 4978.0 4882.8 4897.9 4902.7 4907.4 4907.9 5347.1 5347.5 5354.1 5365.4 5395.9 4207.3 4300.4 4307.0 4329.7 4338.2 5286.5 5460.5 5510.6 5555.9 5657.9 4465.7 4482.8 4486.4 4486.4 4489.2 4538.8 4551.8 4552.2 4558.9 4560.7 4542.6 4607.2 4881.7 4893.8 4912.1 5329.8 5342.5 5358.2 5359.9 5361.2 1567.5 1572.6 1579.1 1581.5 1588.7 1152.5 1183.4 1195.3 1200.8 1217.9 4706.2 4707.0 4707.0 4714.9 4715.3 5538.9 5543.1 5543.6 5547.8 5548.4 4601.3 4658.4 4696.8 4698.2 4725.1 2895.9 2932.7 2942.6 2945.2 2945.4 5183.5 5186.0 5186.5 5194.2 5208.5 5438.9 5605.9 5626.9 5630.4 5650.4 5107.6 5146.6 5151.9 5182.5 5215.7 5341.5 5424.5 5509.6 5516.6 5534.0 5389.3 5391.1 5398.9 5412.9 5458.3 4966.8 5095.9 5118.4 5138.2 5163.5 4218.3 4311.6 4330.4 4335.8 4439.1 5487.5 5501.0 5504.9 5505.1 5509.9 5218.1 5329.4 5338.6 5357.8 5370.5 5327.9 5340.5 5351.2 5367.5 5367.7 5064.4 5258.3 5272.3 5288.7 5294.7 5336.5 5347.7 5363.6 5374.5 5379.7 5209.8 5219.4 5238.1 5240.6 5250.2 05:46:40 INFO - PID 21615 | 05:46:40 INFO - PID 21615 | [#5] yui.html Cycles:180 Average:14190.21 Median:24972.25 stddev:17385.32 (69.6%) stddev-sans-first:17404.09 05:46:40 INFO - PID 21615 | Values: 589.1 593.7 602.7 605.8 632.5 12044.3 12262.3 12404.4 12727.2 13256.7 12617.7 13008.2 13021.4 13030.7 13040.0 633.5 647.2 824.9 828.2 852.4 850.9 852.1 852.7 853.2 853.6 895.8 904.6 904.6 905.7 906.6 897.6 898.7 898.9 899.2 900.4 658.8 659.3 660.3 660.7 661.2 11525.9 11550.8 11565.2 11725.7 13412.3 11911.7 12451.2 12755.1 13149.7 13208.7 12236.2 12242.6 12301.5 12454.6 12507.4 4109.7 4142.2 4208.1 4223.4 4375.9 58967.0 59739.4 60511.5 60731.7 60823.4 10671.6 10723.5 10751.1 10808.3 10976.1 20313.3 20349.6 20361.6 20473.6 20632.6 6150.8 6436.3 6495.6 6577.2 6691.2 3261.6 3344.3 3344.7 3397.3 3406.6 2741.5 2778.3 2799.9 2809.4 2815.2 486.9 494.6 495.5 498.5 499.7 580.9 593.9 596.6 605.6 605.9 8343.8 8637.4 8684.3 9088.2 9242.3 498.0 502.9 504.7 511.9 514.1 4228.4 4266.2 4353.5 4408.5 4462.0 58255.4 61202.7 62731.7 62920.4 63157.7 53088.0 53392.0 53614.5 54151.5 55617.7 48647.8 49449.0 50090.0 50392.2 50709.2 7879.3 8010.4 8403.2 8547.2 8596.1 34381.0 34773.1 34881.7 35176.0 35827.5 40514.6 41307.4 42017.8 42134.4 42744.6 9924.3 9980.2 9996.0 10134.4 10215.1 10842.8 11116.8 11238.0 11791.2 11884.7 10248.4 10504.7 10662.7 10672.4 10769.7 10006.7 10098.3 10326.2 10567.7 10706.1 10329.9 10712.9 10754.9 10855.0 11062.9 8404.8 8448.2 8717.9 8722.3 8765.9 7878.2 8124.8 8251.9 8541.3 9921.5 05:46:40 INFO - PID 21615 | -------- Summary: end -------- 05:46:40 INFO - PID 21615 | 05:46:41 INFO - TEST-INFO | 21615: exit 0 05:46:41 INFO - TEST-OK | dromaeo_css | took 1123182ms 05:46:41 INFO - TEST-START | kraken 05:46:41 INFO - operating with platform_type : linux_ 05:46:41 INFO - Initialising browser for kraken test... 05:46:41 INFO - TEST-INFO | started process 21942 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTmTRVR/profile http://localhost:44325/getInfo.html) 05:46:45 INFO - PID 21942 | __metrics Screen width/height:1600/1200 05:46:45 INFO - PID 21942 | colorDepth:24 05:46:45 INFO - PID 21942 | Browser inner width/height: 1024/697 05:46:45 INFO - PID 21942 | __metrics 05:46:46 INFO - PID 21942 | 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" 05:46:46 INFO - PID 21942 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:46:47 INFO - TEST-INFO | 21942: exit 0 05:46:47 INFO - Browser initialized. 05:46:47 INFO - Running cycle 1/1 for kraken test... 05:46:47 INFO - TEST-INFO | started process 22037 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTmTRVR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:46:59 INFO - PID 22037 | RSS: Main: 153632768 05:46:59 INFO - PID 22037 | 05:47:02 INFO - PID 22037 | Cycle 1(1): loaded http://localhost:44325/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44325/tests/kraken/driver.html?testName=audio-beat-detection) 05:47:03 INFO - PID 22037 | RSS: Main: 204095488 05:47:03 INFO - PID 22037 | 05:47:05 INFO - PID 22037 | Cycle 1(1): loaded http://localhost:44325/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44325/tests/kraken/driver.html?testName=audio-dft) 05:47:06 INFO - PID 22037 | RSS: Main: 184344576 05:47:06 INFO - PID 22037 | 05:47:09 INFO - PID 22037 | Cycle 1(1): loaded http://localhost:44325/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44325/tests/kraken/driver.html?testName=audio-fft) 05:47:10 INFO - PID 22037 | RSS: Main: 266842112 05:47:10 INFO - PID 22037 | 05:47:12 INFO - PID 22037 | Cycle 1(1): loaded http://localhost:44325/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44325/tests/kraken/driver.html?testName=audio-oscillator) 05:47:12 INFO - PID 22037 | RSS: Main: 177799168 05:47:12 INFO - PID 22037 | 05:47:15 INFO - PID 22037 | Cycle 1(1): loaded http://localhost:44325/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44325/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:47:15 INFO - PID 22037 | RSS: Main: 180862976 05:47:15 INFO - PID 22037 | 05:47:18 INFO - PID 22037 | Cycle 1(1): loaded http://localhost:44325/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44325/tests/kraken/driver.html?testName=imaging-darkroom) 05:47:19 INFO - PID 22037 | RSS: Main: 219115520 05:47:19 INFO - PID 22037 | 05:47:23 INFO - PID 22037 | Cycle 1(1): loaded http://localhost:44325/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44325/tests/kraken/driver.html?testName=imaging-desaturate) 05:47:23 INFO - PID 22037 | RSS: Main: 214032384 05:47:23 INFO - PID 22037 | 05:47:26 INFO - PID 22037 | Cycle 1(1): loaded http://localhost:44325/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44325/tests/kraken/driver.html?testName=json-parse-financial) 05:47:27 INFO - PID 22037 | RSS: Main: 216309760 05:47:27 INFO - PID 22037 | 05:47:29 INFO - PID 22037 | Cycle 1(1): loaded http://localhost:44325/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44325/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:47:29 INFO - PID 22037 | RSS: Main: 180305920 05:47:29 INFO - PID 22037 | 05:47:31 INFO - PID 22037 | Cycle 1(1): loaded http://localhost:44325/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44325/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:47:32 INFO - PID 22037 | RSS: Main: 187416576 05:47:32 INFO - PID 22037 | 05:47:34 INFO - PID 22037 | Cycle 1(1): loaded http://localhost:44325/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44325/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:47:34 INFO - PID 22037 | RSS: Main: 196132864 05:47:34 INFO - PID 22037 | 05:47:37 INFO - PID 22037 | Cycle 1(1): loaded http://localhost:44325/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44325/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:47:38 INFO - PID 22037 | RSS: Main: 205561856 05:47:38 INFO - PID 22037 | 05:47:41 INFO - PID 22037 | Cycle 1(1): loaded http://localhost:44325/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44325/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:47:42 INFO - PID 22037 | RSS: Main: 201736192 05:47:42 INFO - PID 22037 | 05:47:44 INFO - PID 22037 | Cycle 1(1): loaded http://localhost:44325/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44325/tests/kraken/driver.html?testName=ai-astar) 05:47:44 INFO - PID 22037 | RSS: Main: 270647296 05:47:44 INFO - PID 22037 | 05:47:44 INFO - PID 22037 | __start_tp_report 05:47:44 INFO - PID 22037 | _x_x_mozilla_page_load 05:47:44 INFO - PID 22037 | _x_x_mozilla_page_load_details 05:47:44 INFO - PID 22037 | |i|pagename|runs| 05:47:44 INFO - PID 22037 | |0;ai-astar;117;119;117;120;118;118;120;117;119;118 05:47:44 INFO - PID 22037 | |1;audio-beat-detection;154;125;126;162;137;123;125;123;150;124 05:47:44 INFO - PID 22037 | |2;audio-dft;161;164;164;162;164;163;163;163;163;164 05:47:44 INFO - PID 22037 | |3;audio-fft;74;76;75;105;82;76;75;75;99;77 05:47:44 INFO - PID 22037 | |4;audio-oscillator;84;85;107;84;84;84;100;85;84;115 05:47:44 INFO - PID 22037 | |5;imaging-gaussian-blur;114;114;113;114;113;114;113;113;114;113 05:47:44 INFO - PID 22037 | |6;imaging-darkroom;149;151;150;150;149;150;150;149;150;149 05:47:44 INFO - PID 22037 | |7;imaging-desaturate;93;94;94;94;94;94;94;94;94;94 05:47:44 INFO - PID 22037 | |8;json-parse-financial;66;66;67;65;66;67;68;70;68;67 05:47:44 INFO - PID 22037 | |9;json-stringify-tinderbox;55;56;57;56;55;56;56;56;56;56 05:47:44 INFO - PID 22037 | |10;stanford-crypto-aes;82;84;82;83;82;83;84;83;83;82 05:47:44 INFO - PID 22037 | |11;stanford-crypto-ccm;152;138;136;149;137;132;131;136;182;130 05:47:44 INFO - PID 22037 | |12;stanford-crypto-pbkdf2;184;196;196;195;196;194;194;194;194;196 05:47:44 INFO - PID 22037 | |13;stanford-crypto-sha256-iterative;71;73;70;69;70;69;73;70;71;78 05:47:44 INFO - PID 22037 | __end_tp_report 05:47:44 INFO - PID 22037 | __start_cc_report 05:47:44 INFO - PID 22037 | _x_x_mozilla_cycle_collect,1990 05:47:44 INFO - PID 22037 | __end_cc_report 05:47:44 INFO - PID 22037 | __startTimestamp1489582064392__endTimestamp 05:47:44 INFO - PID 22037 | 05:47:44 INFO - PID 22037 | ------- Summary: start ------- 05:47:44 INFO - PID 22037 | Number of tests: 14 05:47:44 INFO - PID 22037 | 05:47:44 INFO - PID 22037 | [#0] ai-astar Cycles:10 Average:118.30 Median:118.50 stddev:1.16 (1.0%) stddev-sans-first:1.13 05:47:44 INFO - PID 22037 | Values: 117.0 119.0 117.0 120.0 118.0 118.0 120.0 117.0 119.0 118.0 05:47:44 INFO - PID 22037 | 05:47:44 INFO - PID 22037 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:131.50 stddev:14.94 (11.4%) stddev-sans-first:14.16 05:47:44 INFO - PID 22037 | Values: 154.0 125.0 126.0 162.0 137.0 123.0 125.0 123.0 150.0 124.0 05:47:44 INFO - PID 22037 | 05:47:44 INFO - PID 22037 | [#2] audio-dft Cycles:10 Average:163.10 Median:163.50 stddev:0.99 (0.6%) stddev-sans-first:0.71 05:47:44 INFO - PID 22037 | Values: 161.0 164.0 164.0 162.0 164.0 163.0 163.0 163.0 163.0 164.0 05:47:44 INFO - PID 22037 | 05:47:44 INFO - PID 22037 | [#3] audio-fft Cycles:10 Average:81.40 Median:76.00 stddev:11.17 (14.7%) stddev-sans-first:11.52 05:47:44 INFO - PID 22037 | Values: 74.0 76.0 75.0 105.0 82.0 76.0 75.0 75.0 99.0 77.0 05:47:44 INFO - PID 22037 | 05:47:44 INFO - PID 22037 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:84.00 stddev:11.69 (13.9%) stddev-sans-first:12.10 05:47:44 INFO - PID 22037 | Values: 84.0 85.0 107.0 84.0 84.0 84.0 100.0 85.0 84.0 115.0 05:47:44 INFO - PID 22037 | 05:47:44 INFO - PID 22037 | [#5] imaging-gaussian-blur Cycles:10 Average:113.50 Median:114.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 05:47:44 INFO - PID 22037 | Values: 114.0 114.0 113.0 114.0 113.0 114.0 113.0 113.0 114.0 113.0 05:47:44 INFO - PID 22037 | 05:47:44 INFO - PID 22037 | [#6] imaging-darkroom Cycles:10 Average:149.70 Median:150.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 05:47:44 INFO - PID 22037 | Values: 149.0 151.0 150.0 150.0 149.0 150.0 150.0 149.0 150.0 149.0 05:47:44 INFO - PID 22037 | 05:47:44 INFO - PID 22037 | [#7] imaging-desaturate Cycles:10 Average:93.90 Median:94.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 05:47:44 INFO - PID 22037 | Values: 93.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 94.0 05:47:44 INFO - PID 22037 | 05:47:44 INFO - PID 22037 | [#8] json-parse-financial Cycles:10 Average:67.00 Median:67.00 stddev:1.41 (2.1%) stddev-sans-first:1.45 05:47:44 INFO - PID 22037 | Values: 66.0 66.0 67.0 65.0 66.0 67.0 68.0 70.0 68.0 67.0 05:47:44 INFO - PID 22037 | 05:47:44 INFO - PID 22037 | [#9] json-stringify-tinderbox Cycles:10 Average:55.90 Median:56.00 stddev:0.57 (1.0%) stddev-sans-first:0.50 05:47:44 INFO - PID 22037 | Values: 55.0 56.0 57.0 56.0 55.0 56.0 56.0 56.0 56.0 56.0 05:47:44 INFO - PID 22037 | 05:47:44 INFO - PID 22037 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:0.79 (1.0%) stddev-sans-first:0.78 05:47:44 INFO - PID 22037 | Values: 82.0 84.0 82.0 83.0 82.0 83.0 84.0 83.0 83.0 82.0 05:47:44 INFO - PID 22037 | 05:47:44 INFO - PID 22037 | [#11] stanford-crypto-ccm Cycles:10 Average:142.30 Median:137.50 stddev:15.73 (11.4%) stddev-sans-first:16.28 05:47:44 INFO - PID 22037 | Values: 152.0 138.0 136.0 149.0 137.0 132.0 131.0 136.0 182.0 130.0 05:47:44 INFO - PID 22037 | 05:47:44 INFO - PID 22037 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.90 Median:195.50 stddev:3.60 (1.8%) stddev-sans-first:1.00 05:47:44 INFO - PID 22037 | Values: 184.0 196.0 196.0 195.0 196.0 194.0 194.0 194.0 194.0 196.0 05:47:44 INFO - PID 22037 | 05:47:44 INFO - PID 22037 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.40 Median:71.00 stddev:2.72 (3.8%) stddev-sans-first:2.88 05:47:44 INFO - PID 22037 | Values: 71.0 73.0 70.0 69.0 70.0 69.0 73.0 70.0 71.0 78.0 05:47:44 INFO - PID 22037 | -------- Summary: end -------- 05:47:44 INFO - PID 22037 | 05:47:45 INFO - TEST-INFO | 22037: exit 0 05:47:45 INFO - TEST-OK | kraken | took 64429ms 05:47:45 INFO - SUITE-END | took 1187s 05:47:46 INFO - Completed test suite (00:19:48) 05:47:46 INFO - javascript benchmark 05:47:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6619.554198936853, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2601.271643939697, 2645.140329392948, 2669.7330266973304, 2670.279024663341, 2672.0247109804927, 4834.975825120879, 4924.433690125627, 4930.876728081796, 4941.9011619767625, 4992.825251116212, 4886.853394398165, 4938.629602779788, 4939.58013568847, 4984.327115839361, 4987.202047672373, 4461.464624245095, 4480.238359478896, 4509.030558429937, 4569.954300457002, 4588.449386073659, 4581.266997280436, 4601.309803529464, 4614.792334344946, 4620.97689511552, 4664.323673067403, 4400.4939431965095, 4454.2873140297725, 4456.9331460028125, 4552.317152427129, 4555.817767289304, 4524.954750452486, 4558.339040839093, 4569.29175977724, 4610.05493873755, 4614.192516309632, 4503.1218912312115, 4521.434820647419, 4529.026259354222, 4544.613707834838, 4580.473245576734, 4820.951790482085, 4957.950420495785, 4964.90070198594, 4975.4029516457895, 4986.900261994776, 5262.552683021948, 5285.233641122016, 5287.47125287472, 5288.0745869472685, 5290.365156181283, 5290.338707661543, 5301.019311427398, 5318.175682769177, 5358.97320513395, 5405.297311349499, 5021.196608542616, 5025.296458495814, 5026.145555255615, 5030.37120359955, 5043.167877300204, 5433.809816656398, 5495.642783219078, 5499.1476321170285, 5503.3120859892515, 5530.474604912527, 5100.6429549931145, 5148.099082660519, 5148.2020286855595, 5150.665206761623, 5170.689758614495, 5208.192730126836, 5267.473252674778, 5270.5256526912, 5272.525472707474, 5273.472652734696, 5256.0, 5273.31446911899, 5275.3142091528625, 5276.129438642581, 5286.154215325606, 5237.921431178535, 5267.183586544092, 5317.255584218213, 5319.867003324948, 5324.094903866352, 4482.058767658763, 4501.572350626685, 4503.121891231244, 4504.166729155117, 4548.1813273610405, 3810.7713537187856, 3890.90272743178, 3899.532056153223, 3932.05630648648, 3996.9200615987515, 4479.776011199492, 4545.772711364419, 4566.315052742115, 4580.358749775034, 4581.541845815392, 5315.973420132875, 5322.441143679858, 5359.812406565751, 5365.517103460707, 5372.033034053829, 4543.0, 4544.795484203219, 4545.749983750859, 4547.272436410159, 4590.563896429834, 4618.445786505641, 4686.461056978491, 4750.691205071659, 4755.857324280277, 4809.855704328876, 4922.655414120977, 4934.457209706858, 4969.031038947371, 4974.37820272466, 4986.9251961221335, 5329.626926115135, 5331.5201631853315, 5346.812861549827, 5347.278117454094, 5437.157240627709, 4893.339399181065, 5016.774245158904, 5017.0, 5020.523050310215, 5021.924671129863, 5147.5881929446305, 5235.476452354734, 5294.708791016531, 5306.8407947761625, 5311.49540793624, 5341.225522299323, 5343.9465605345, 5344.572434205176, 5346.492083252085, 5351.331083614548, 5140.897182056413, 5193.11717008102, 5196.636235463481, 5202.73986300691, 5252.5535329497425, 5000.699958002531, 5025.095482813129, 5134.12719837636, 5168.121419358643, 5193.974030129825, 5119.0529751996, 5123.129068058364, 5127.692338459704, 5128.410232823124, 5151.974240128776, 5025.47232540578, 5093.7707803148205, 5095.566876815512, 5099.235114732672, 5223.843284701465, 5006.949930500648, 5008.974955125201, 5018.874528136826, 5018.974905125451, 5020.071286811952], "value": 4853.675133218724, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [691.9757808476703, 714.0538786108406, 775.0815283888593, 787.7046107709613, 789.1910791438771, 31959.36081278373, 32824.835875820616, 32929.83535082324, 33028.83485582575, 33059.83470082652, 33221.33557328858, 33697.0, 33883.15292117698, 33920.49119263207, 33922.49116263258, 6696.933030669679, 6884.380405763481, 7378.667959941802, 7539.0, 7546.0, 8898.332625053115, 9097.499637519933, 9113.681021164228, 9115.863262051074, 9116.58975346111, 9243.584038718274, 9308.488033158173, 9311.115444032806, 9335.159835614793, 9335.579898904565, 9409.294302927274, 9490.288228382899, 9505.42967421957, 9509.0, 9510.239180865514, 9301.441913485212, 9341.953290233574, 9381.390209636353, 9383.108604682544, 9391.201747851372, 34243.82878085619, 34416.13959651004, 34492.82753586241, 34511.654883451345, 34534.0, 3173.220630882973, 3211.373782112489, 3217.871285148591, 3247.4804031355106, 3292.720118789906, 23627.527449450914, 24038.75961240383, 24171.758282417304, 24288.757112429004, 24818.5036299273, 3167.857446414917, 3177.4121787469394, 3204.150900011499, 3241.205904553376, 3351.145457908218, 159505.0, 159603.0, 159943.0, 160031.99999999884, 160369.0, 32787.67212327894, 33162.0, 36790.44814327787, 43270.13459730788, 43494.0, 39464.60535394667, 39508.802455987534, 39530.60469395327, 39690.60309396869, 39724.40413393801, 11265.324080555192, 11390.0, 11401.828972565418, 11409.42952852354, 11411.258268212705, 8935.955320223356, 8937.776555586162, 8940.3741738079, 8951.41815781972, 8963.193312601898, 12682.936585317015, 12685.936570317273, 12696.6825829355, 12700.618981430573, 12760.489580416865, 5222.216667499905, 5243.344581927259, 5259.552938000313, 5301.602379821529, 5346.0, 1024.5594394410475, 1046.0585473074293, 1047.3899399087197, 1050.3592808386877, 1066.706655669697, 22482.100715971177, 22559.774402255767, 22683.319500415015, 22725.204617838626, 22828.65757013646, 1072.383379556758, 1099.8295264234057, 1110.6945589962825, 1117.871444783844, 1132.9773404531863, 11257.380844053656, 12186.878131218751, 12202.14584979043, 12205.0, 12211.26732396059, 202878.0, 203018.0, 203070.0, 203279.0, 203718.0, 41179.7941010293, 41215.1756964859, 41794.79102604467, 41872.37191442131, 41907.79046104811, 1187.31401409998, 1225.4791713521895, 1235.2588446931768, 1241.7392347606742, 1244.520859469111, 20309.49226269355, 20373.69439458439, 21276.0, 21913.890430548385, 23366.53266934686, 35595.0, 35678.464823027156, 36829.63170368369, 36894.262114758094, 36916.261674766894, 168591.0, 168812.0, 168870.0, 169125.0, 169423.1528842348, 22363.0, 22715.0, 22823.657645135005, 25887.611685825104, 28249.15252542427, 31074.22314442157, 31163.37673246477, 31350.216244594067, 31593.8420307897, 31676.5248521277, 26374.20877373682, 26822.463550729266, 26904.461910762067, 27061.323466913484, 27132.32169195707, 26857.86571067132, 27140.592891106255, 28093.438131237668, 28157.0, 28708.85645571759, 29006.46139119407, 29229.707702923548, 29281.0, 31178.22054448657, 31509.951853129474, 25656.501059195518, 27990.860045700454, 28002.159935201977, 28264.434711305246, 28391.148265552067, 21967.0, 22032.669509957042, 22043.889780550995, 22075.33773986783, 22328.441788955406], "value": 15117.655036420452, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [361.6925613228754, 386.2603115034707, 416.3338658146964, 418.0072328220476, 420.7832966022499, 11902.006551203343, 13270.933645331772, 13376.264305463195, 17818.0, 18040.18819153138, 16907.323707051703, 17132.229049692764, 17304.221310041048, 17435.389761358354, 17461.1269436528, 5391.514763671269, 5646.887062258752, 5649.406812284713, 5661.122526008455, 5753.971230143843, 5737.282839645044, 5839.32847722511, 6596.109525214083, 6861.941417574732, 6897.137857767779, 6817.795466136024, 6864.862702745942, 6879.3120687931305, 6883.724651013953, 6885.655717214145, 6748.325167483237, 6875.278095799919, 6889.931100688979, 6902.482313826483, 6902.551334163263, 6671.332866713338, 6721.663916804189, 6729.899051514182, 6810.387065164109, 6896.344847239504, 21162.365129046153, 21469.463263418384, 21905.561888762135, 22537.887310563507, 22766.31701048971, 2368.3723813189517, 2397.2568503763714, 2414.0705828256073, 2419.0807493152665, 2470.258922323296, 13904.513342033082, 13909.026368154233, 14128.788068178985, 14306.785398219035, 14866.0, 1894.914728837192, 1901.1558389796621, 1907.5517253445569, 1940.5827747034455, 1972.7336809530673, 84851.0, 85547.57226213829, 86358.56820715919, 87303.0, 90631.54684226536, 16171.676566468605, 16432.671346573003, 16602.418915337905, 16770.58073548171, 16998.0, 29524.852375737984, 29539.556906646416, 29556.408871822445, 29642.703572964427, 29739.10782676523, 8415.34574772887, 8517.209841620543, 8591.410589041048, 8841.336899732545, 8912.242459390895, 6957.617331046841, 7040.436765058783, 7165.713371465187, 7220.927790722026, 7240.4569657275915, 8863.309352517985, 9082.273418126533, 9143.988322569025, 9199.816003679889, 9358.298127640319, 3543.7696549724187, 3574.57105147384, 3672.9632703673155, 3708.8145592720257, 3745.2135051638916, 948.5494390164616, 962.8363178259573, 987.9555420006117, 998.8851282102506, 1051.3534176481562, 17318.913405432893, 17901.552461188574, 18438.723419148722, 20570.88865682039, 21883.10591228489, 878.8286284174652, 889.3374436045059, 897.699270744308, 908.6728777640044, 913.8172365526921, 9851.605935762489, 10897.400642964554, 10913.0, 10915.0, 10923.945380273048, 464827.0, 466120.0, 471049.0, 531885.0, 533012.0, 75313.62343188249, 85661.0, 85843.57078214694, 87518.56240718755, 87724.12275877288, 1070.7055559721139, 1124.3085502415956, 1135.0125390909961, 1143.5311522275993, 1145.0667705819565, 16195.59511012187, 16257.26842292076, 16617.41839035628, 16976.74534881953, 17113.14434278306, 35868.820655897594, 37788.81105594454, 41765.0, 42282.78858605687, 44434.0, 52844.20733688921, 52967.47032529626, 53007.0, 53559.46440535545, 55390.169147463625, 10122.544485498023, 10229.488525573543, 10843.132549395872, 10851.45742712877, 11352.943235284101, 11537.250078744855, 12260.080493963167, 12347.13570050088, 12858.292793896426, 12890.226586404846, 10223.386596804216, 10351.585936562453, 10497.212709047004, 11090.778184436427, 11328.263662862217, 10749.623763168564, 11297.943510282395, 11335.206535542433, 11418.657440276806, 11479.36863472517, 10436.425996570262, 10753.139748820233, 11488.138389620644, 11786.882131178578, 11925.82111268349, 10147.949260253652, 10218.744531386776, 10228.386296822215, 10251.58993640246, 10651.573937042742, 11069.391183484664, 11151.330920144817, 11222.831657524981, 11480.712982175512, 11721.648350549498], "value": 9992.121412507404, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1294.7539967406199, 1478.7560052591323, 1480.570634515991, 1509.2001239343144, 1519.5686900958467, 7949.24482174194, 8803.383763136575, 9234.538273086344, 9354.579043943022, 9355.391899526527, 9291.767705807359, 9466.100720431548, 9487.38332008419, 9494.572744226509, 9504.76238094048, 1720.0625659015805, 2046.447459186019, 2093.9581208375826, 2102.7686954435, 2104.231955336299, 1769.9380521681744, 2050.764162121353, 2111.134434881699, 2112.4824418017606, 2125.341144245281, 2042.6425375559293, 2056.4139220322213, 2064.1330641130685, 2064.61804566155, 2074.813266805987, 1950.5221220800852, 1973.4572992427054, 1984.5137941204353, 1988.443235893952, 1999.7700264469481, 1915.990420047891, 1961.7743959444704, 1968.2422267427, 1980.7524059492564, 1991.71120187572, 9390.906090939072, 9471.242300615933, 9472.763180920463, 9496.952515237448, 9521.761955951088, 4489.865304040884, 4629.305604159369, 4641.257398816173, 4642.814287428499, 4651.279051746985, 2427.174760581393, 2675.4782817350624, 2719.075514325139, 2727.686316073657, 2731.1533424638424, 972.0813830929774, 1020.4948550467492, 1021.0300214795974, 1031.1853635627845, 1054.6256079091966, 13186.07697461178, 13358.131721438172, 13409.731805363936, 13432.126911750802, 13462.865371346259, 3809.6190380962234, 3942.1721438498234, 4032.495938007749, 4035.596440355941, 4162.980954237192, 11858.703532411586, 11877.990370818405, 11879.109066820023, 11898.881011189951, 11908.106891983136, 4700.388949436619, 4701.200795864711, 4714.528547145258, 4717.764111794397, 4722.905541889212, 3497.4753786932165, 3514.4903988921465, 4153.314703073959, 4303.74177549348, 4308.482982042112, 3624.383854744647, 3708.38811596089, 3725.1618385863508, 3790.9241815164096, 3794.772313661189, 1044.1646682653848, 1045.383223897904, 1046.1055797293357, 1063.8244689626124, 1073.3184427888348, 748.8165399477163, 750.2122771090334, 762.7635433015782, 771.6103367799337, 782.4210084537515, 5812.796552120655, 5907.881842363128, 5986.2517185351835, 6004.789832355847, 6152.384761523812, 892.6340200517886, 901.4906577783531, 902.9051949545335, 908.6910450446748, 929.2612373163352, 3719.8512059517316, 3758.755680880734, 3783.0, 3793.6585707286476, 3828.5979972102527, 10866.891331086588, 11292.717682058013, 11300.321980681185, 11301.20891537601, 11321.207515473838, 11004.064654504296, 11147.554097835995, 11161.0, 11172.776544469065, 11175.0, 8291.461055031403, 8368.83262334762, 8439.282660973764, 8596.398252122292, 8603.569821509025, 5971.552133590085, 6149.96925015372, 6192.845178870384, 6238.282597501164, 6244.968775156095, 10706.571737130427, 10921.071708904832, 10976.725581860517, 10984.395858227874, 11017.394043327373, 11318.434078295888, 11405.0, 11571.421428928352, 11577.536898523964, 11578.594749183738, 6461.0954466373805, 6746.257911629815, 7287.0, 7342.265773422615, 7437.888431673421, 8605.483670979762, 8606.741797746077, 8706.738797836075, 8708.956455217936, 8712.69505567302, 7301.853962920818, 7312.305330993547, 7324.926750732638, 7536.585487798005, 7689.154193038873, 7245.855082898418, 7577.204393538819, 7597.430192735677, 7611.847763044598, 7623.809404764926, 6833.145856767904, 7024.719011239493, 7030.789076327718, 7032.331928466788, 7033.226345101933, 5258.368995720385, 5301.920471193012, 5397.082495975615, 5409.945900540944, 5495.368032676133, 5330.360356757059, 5335.199720042025, 5366.302380690485, 5416.620836541404, 5504.9174262385295], "value": 4436.7781226197885, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [360.62134758503566, 364.73921146380343, 376.4898562447883, 377.1062581681414, 382.10396619926263, 5173.5425672805495, 5175.8188463403785, 5214.374275086985, 5217.634765566407, 5223.138182199932, 4822.252550854614, 4939.950600493994, 4972.651914365996, 5012.899742005157, 5088.720120393377, 4234.30134027885, 4245.469316335458, 4246.150769846027, 4251.0860165064505, 4258.829646814139, 4231.4710661167355, 4242.087951090515, 4256.659467242614, 4262.6589872810255, 4267.445232119836, 4036.919261614766, 4182.958170418303, 4247.660187185018, 4248.936265956013, 4255.234057869582, 4206.600372964579, 4208.768517731508, 4211.957880421218, 4218.557051509578, 4222.936655950163, 3914.1388894443176, 3921.627445392683, 3930.5479869815053, 3931.9213615727813, 3934.8229329680235, 4831.396075490564, 4952.678075925053, 4962.1812400953795, 4973.452920178777, 4978.033676697684, 4882.804687812483, 4897.853064408074, 4902.705837649717, 4907.4356449008465, 4907.8773030674165, 5347.064263753828, 5347.518723314882, 5354.063038968165, 5365.409804921455, 5395.892082158335, 4207.326827707552, 4300.397944287803, 4307.0, 4329.675274354436, 4338.240807858612, 5286.524212820865, 5460.481254280837, 5510.586705997026, 5555.8888822223325, 5657.915131273035, 4465.732056076646, 4482.775861206992, 4486.371907932892, 4486.439195100613, 4489.169503641837, 4538.750368729686, 4551.7724113794175, 4552.203364411214, 4558.863234102916, 4560.674056231346, 4542.636589072867, 4607.193741095295, 4881.682690625098, 4893.804247830119, 4912.1158191525155, 5329.81345652908, 5342.545883599938, 5358.223057656696, 5359.892802143935, 5361.249425080492, 1567.4670611991978, 1572.5518227305163, 1579.1472604793282, 1581.5176371206662, 1588.7378582533984, 1152.5159433038143, 1183.402381797187, 1195.3425615911215, 1200.7778560966249, 1217.9343074809542, 4706.1528924793865, 4706.952930470651, 4707.0, 4714.929276060861, 4715.292706094045, 5538.944610553843, 5543.1408131739645, 5543.556515478752, 5547.834954659486, 5548.445155484419, 4601.309803529497, 4658.440987081572, 4696.8121275148615, 4698.201305778026, 4725.125851717443, 2895.885084242582, 2932.72139146785, 2942.558616207586, 2945.175350901751, 2945.4256419998324, 5183.45573714762, 5185.954955135001, 5186.455422180617, 5194.22086687, 5208.463503266546, 5438.857839853596, 5605.934872374236, 5626.915596266059, 5630.352509461382, 5650.378458369576, 5107.5994282687825, 5146.639735218499, 5151.896962060738, 5182.455842136596, 5215.739213039409, 5341.4925582069645, 5424.511793938565, 5509.586780991362, 5516.586256030894, 5533.972330138324, 5389.299391079135, 5391.137418013099, 5398.919016214839, 5412.891742165056, 5458.317710286215, 4966.776495057658, 5095.872603184802, 5118.436971933159, 5138.177891537336, 5163.4578369270685, 4218.346156345771, 4311.5903989122235, 4330.41539392178, 4335.80488877995, 4439.112177564564, 5487.451254874481, 5500.972495137658, 5504.9174262385295, 5505.119180931032, 5509.889802204014, 5218.060749065205, 5329.3604767426605, 5338.572914166935, 5357.78568857257, 5370.549951513148, 5327.866803329948, 5340.49265319794, 5351.1973204019705, 5367.490088441592, 5367.704776237344, 5064.392272927125, 5258.263843062051, 5272.2882410874045, 5288.709120998382, 5294.682319060868, 5336.519713225673, 5347.705876176848, 5363.597730170331, 5374.489423504917, 5379.67721936685, 5209.817656382009, 5219.373675159005, 5238.109521381298, 5240.624078894014, 5250.159974404077], "value": 4207.255076440849, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [589.1339730596022, 593.6705128653597, 602.6504627316156, 605.751641826851, 632.5256057956533, 12044.277343359394, 12262.325572093532, 12404.379781010946, 12727.236365818057, 13256.668583285398, 12617.747645047093, 13008.219506829597, 13021.414036368362, 13030.73938521229, 13040.0, 633.5185259202992, 647.1522305779421, 824.8680211166214, 828.2090603473698, 852.3862818770475, 850.9021462531795, 852.0797538658235, 852.7313896122732, 853.1937319233327, 853.6201390381283, 895.7536677413731, 904.5567671840784, 904.606496174163, 905.7237542549519, 906.6282824042144, 897.6499165325529, 898.6854600889702, 898.8966268879065, 899.1727610598233, 900.3652425040331, 658.799066284783, 659.3176062775053, 660.3132741948368, 660.6597602234853, 661.1702313596405, 11525.942370288094, 11550.826737598944, 11565.248258863232, 11725.70685732855, 13412.329383530785, 11911.702207444883, 12451.190672606343, 12755.06908664522, 13149.671258218525, 13208.73582528344, 12236.204646697935, 12242.632721018384, 12301.507939682402, 12454.626361209179, 12507.437165327583, 4109.691773116998, 4142.150859073882, 4208.116295577902, 4223.408722778813, 4375.890602734925, 58967.0, 59739.40260597382, 60511.48721281959, 60731.69634151801, 60823.391766082656, 10671.573137074585, 10723.517441715141, 10751.139908807276, 10808.29746066519, 10976.12191024716, 20313.289034884005, 20349.59300814005, 20361.592768144554, 20473.590528189354, 20632.58734825325, 6150.753969841246, 6436.3241859605005, 6495.610263384212, 6577.177852768404, 6691.197056353269, 3261.575995120619, 3344.2642618623863, 3344.6655334466845, 3397.3375191837354, 3406.6395014381633, 2741.5476446386124, 2778.305423644089, 2799.8740056697497, 2809.3819359741233, 2815.2258129014276, 486.9440014398319, 494.5894907226993, 495.49212057641205, 498.47162008271346, 499.7176595223687, 580.89834279001, 593.9020061689773, 596.6181643748005, 605.5942518512608, 605.893968555501, 8343.833262780521, 8637.395382323302, 8684.261837743863, 9088.227500662519, 9242.306826988002, 498.0, 502.8818227716484, 504.6921377959442, 511.93344865168035, 514.0951924612634, 4228.386883901879, 4266.189424009491, 4353.499347575006, 4408.515063343029, 4461.977690111528, 58255.41744582585, 61202.69398652978, 62731.686341568915, 62920.370796292365, 63157.684211579566, 53088.0, 53392.0, 53614.46385536095, 54151.45848541543, 55617.72191139018, 48647.75676121597, 49449.0, 50090.0, 50392.24411633828, 50709.23936140961, 7879.330256927996, 8010.359171266401, 8403.243708066304, 8547.230749232598, 8596.140385961355, 34381.0, 34773.13067173341, 34881.65118348784, 35176.0, 35827.462588061724, 40514.59485405226, 41307.38038929358, 42017.78991105025, 42134.36798448087, 42744.572554275306, 9924.255680824112, 9980.201583873419, 9996.0, 10134.442605656759, 10215.13171380441, 10842.78314433691, 11116.777664446827, 11238.0, 11791.233569817934, 11884.702882428008, 10248.436336001592, 10504.737381565523, 10662.73343166427, 10672.359658420519, 10769.730756731144, 10006.69979900604, 10098.293119481566, 10326.173906087344, 10567.735806604589, 10706.089982351275, 10329.9483502582, 10712.946435267773, 10754.946225268823, 10855.0, 11062.944685276521, 8404.789880253042, 8448.197421244971, 8717.869231961398, 8722.302215822845, 8765.912340876765, 7878.212178782076, 8124.796880078045, 8251.860172671844, 8541.316694664287, 9921.51798132321], "value": 6146.859530481874, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1559.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 120.0, 118.0, 118.0, 120.0, 117.0, 119.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 126.0, 162.0, 137.0, 123.0, 125.0, 123.0, 150.0, 124.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 164.0, 164.0, 162.0, 164.0, 163.0, 163.0, 163.0, 163.0, 164.0], "value": 163.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 105.0, 82.0, 76.0, 75.0, 75.0, 99.0, 77.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 107.0, 84.0, 84.0, 84.0, 100.0, 85.0, 84.0, 115.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 113.0, 114.0, 113.0, 114.0, 113.0, 113.0, 114.0, 113.0], "value": 113.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 151.0, 150.0, 150.0, 149.0, 150.0, 150.0, 149.0, 150.0, 149.0], "value": 149.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0, 94.0], "value": 93.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 65.0, 66.0, 67.0, 68.0, 70.0, 68.0, 67.0], "value": 67.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 57.0, 56.0, 55.0, 56.0, 56.0, 56.0, 56.0, 56.0], "value": 55.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 82.0, 83.0, 82.0, 83.0, 84.0, 83.0, 83.0, 82.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 138.0, 136.0, 149.0, 137.0, 132.0, 131.0, 136.0, 182.0, 130.0], "value": 142.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 196.0, 196.0, 195.0, 196.0, 194.0, 194.0, 194.0, 194.0, 196.0], "value": 193.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 73.0, 70.0, 69.0, 70.0, 69.0, 73.0, 70.0, 71.0, 78.0], "value": 71.4, "unit": "score"}]}]} 05:47:46 INFO - Return code: 0 05:47:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:47:46 ERROR - # TBPL SUCCESS # 05:47:46 INFO - Running post-action listener: _resource_record_post_action 05:47:46 INFO - [mozharness: 2017-03-15 12:47:46.188460Z] Finished run-tests step (success) 05:47:46 INFO - Running post-run listener: _resource_record_post_run 05:47:46 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 4096; Write bytes: 356007936; Read time: 16; Write time: 192924 05:47:46 INFO - TinderboxPrint: CPU usage
13.0% 05:47:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 05:47:46 INFO - TinderboxPrint: I/O write bytes / time
356,007,936 / 192,924 05:47:46 INFO - TinderboxPrint: CPU idle
8,363.1 (87.0%) 05:47:46 INFO - TinderboxPrint: CPU user
1,202.4 (12.5%) 05:47:46 INFO - TinderboxPrint: Swap in / out
0 / 0 05:47:46 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 105820160; Read time: 0; Write time: 86760 05:47:46 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 250187776; Read time: 16; Write time: 106164 05:47:46 INFO - Running post-run listener: _upload_blobber_files 05:47:46 INFO - Blob upload gear active. 05:47:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:47:46 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 05:47:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:47:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:47:47 INFO - (blobuploader) - INFO - Open directory for files ... 05:47:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:47:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:47:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:47 INFO - (blobuploader) - INFO - Done attempting. 05:47:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:47:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:48 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:47:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:48 INFO - (blobuploader) - INFO - Done attempting. 05:47:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:47:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:47:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:49 INFO - (blobuploader) - INFO - Done attempting. 05:47:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:47:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:47:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:47:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:47:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:47:52 INFO - (blobuploader) - INFO - Done attempting. 05:47:52 INFO - (blobuploader) - INFO - Iteration through files over. 05:47:52 INFO - Return code: 0 05:47:52 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:47:52 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:47:52 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7b17eb1e3f43d04be5bae0340c84015ede2e39ff91511b2a58d9d9db5d5a263a2d1fc9b12da423a2642b9e057497aebf949418d12569e4c8b718ef1f07fe18a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2896fda8242e7a46c3484b624e735d5d856d4cf801288e7edfdf711690cb513c50d2f0c0c896bab504741cf83745454dbcdcbe3d71282d0bef88677fe76cd40b", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/34e00c223c1b401b68ccd4bc23840df39560c15520fd4665ce9746ea8cadfc1919da48e636edcd8930c819a8fc5a5172332f70e9164e50cdbd4ef2b35d9bbe6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a2097ccd5c15417345db7a9cc23e99f2843a4a61f8b4260583b954f2fe61a8cf3bd59e7b83367628bb2c6b698dc7aed79671e80ad1866682b7629005562b515"} 05:47:52 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:47:52 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:47:52 INFO - Contents: 05:47:52 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7b17eb1e3f43d04be5bae0340c84015ede2e39ff91511b2a58d9d9db5d5a263a2d1fc9b12da423a2642b9e057497aebf949418d12569e4c8b718ef1f07fe18a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2896fda8242e7a46c3484b624e735d5d856d4cf801288e7edfdf711690cb513c50d2f0c0c896bab504741cf83745454dbcdcbe3d71282d0bef88677fe76cd40b", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/34e00c223c1b401b68ccd4bc23840df39560c15520fd4665ce9746ea8cadfc1919da48e636edcd8930c819a8fc5a5172332f70e9164e50cdbd4ef2b35d9bbe6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a2097ccd5c15417345db7a9cc23e99f2843a4a61f8b4260583b954f2fe61a8cf3bd59e7b83367628bb2c6b698dc7aed79671e80ad1866682b7629005562b515"} 05:47:52 INFO - Running post-run listener: copy_logs_to_upload_dir 05:47:52 INFO - Copying logs to upload dir... 05:47:52 INFO - mkdir: /builds/slave/test/build/upload/logs 05:47:52 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1262.318972 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2017-03-15 05:47:52.048945) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 05:47:52.052251) ========= 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=0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467 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-Non-PGO/sha512/f7b17eb1e3f43d04be5bae0340c84015ede2e39ff91511b2a58d9d9db5d5a263a2d1fc9b12da423a2642b9e057497aebf949418d12569e4c8b718ef1f07fe18a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2896fda8242e7a46c3484b624e735d5d856d4cf801288e7edfdf711690cb513c50d2f0c0c896bab504741cf83745454dbcdcbe3d71282d0bef88677fe76cd40b", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/34e00c223c1b401b68ccd4bc23840df39560c15520fd4665ce9746ea8cadfc1919da48e636edcd8930c819a8fc5a5172332f70e9164e50cdbd4ef2b35d9bbe6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a2097ccd5c15417345db7a9cc23e99f2843a4a61f8b4260583b954f2fe61a8cf3bd59e7b83367628bb2c6b698dc7aed79671e80ad1866682b7629005562b515"} build_url:https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011505 build_url: 'https://queue.taskcluster.net/v1/task/CcwqoAPJRTGe2QwjqJGbJQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f7b17eb1e3f43d04be5bae0340c84015ede2e39ff91511b2a58d9d9db5d5a263a2d1fc9b12da423a2642b9e057497aebf949418d12569e4c8b718ef1f07fe18a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/2896fda8242e7a46c3484b624e735d5d856d4cf801288e7edfdf711690cb513c50d2f0c0c896bab504741cf83745454dbcdcbe3d71282d0bef88677fe76cd40b", "dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/34e00c223c1b401b68ccd4bc23840df39560c15520fd4665ce9746ea8cadfc1919da48e636edcd8930c819a8fc5a5172332f70e9164e50cdbd4ef2b35d9bbe6e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7a2097ccd5c15417345db7a9cc23e99f2843a4a61f8b4260583b954f2fe61a8cf3bd59e7b83367628bb2c6b698dc7aed79671e80ad1866682b7629005562b515"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 05:47:52.078171) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 05:47:52.078493) ========= 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=0e2a256762fed810e2f0f810000001b3-1489580808.331596-71275467 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 05:47:52.161692) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 05:47:52.162011) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 05:47:52.162296) ========= ========= Total master_lag: 0.16 =========