builder: mozilla-beta_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-021 starttime: 1488412151.34 results: success (0) buildid: 20170301133922 builduid: b67885b8f9e94199842d821a6b095c0f revision: d1b4c5e38c8fabe11d2b9e9fb79441e53d568381 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-01 15:49:11.342761) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-01 15:49:11.343196) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-01 15:49:11.343478) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-01 15:49:11.360432) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 15:49:11.360826) ========= 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=df17445c3590ff7897617a0e00000225-1488406134.439901-982370674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-03-01 15:49:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 226M=0s 2017-03-01 15:49:11 (226 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.086123 ========= master_lag: 0.16 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 15:49:11.604801) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 15:49:11.605204) ========= 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=df17445c3590ff7897617a0e00000225-1488406134.439901-982370674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015165 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 15:49:11.632323) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-01 15:49:11.635764) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d1b4c5e38c8fabe11d2b9e9fb79441e53d568381 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev d1b4c5e38c8fabe11d2b9e9fb79441e53d568381 --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=df17445c3590ff7897617a0e00000225-1488406134.439901-982370674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-03-01 15:49:11,852 truncating revision to first 12 chars 2017-03-01 15:49:11,852 Setting DEBUG logging. 2017-03-01 15:49:11,852 attempt 1/10 2017-03-01 15:49:11,852 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/d1b4c5e38c8f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-01 15:49:13,231 unpacking tar archive at: mozilla-beta-d1b4c5e38c8f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.705676 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-01 15:49:13.359317) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-01 15:49:13.359964) ========= script_repo_revision: d1b4c5e38c8fabe11d2b9e9fb79441e53d568381 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-01 15:49:13.360367) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-01 15:49:13.360673) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-01 15:49:13.382170) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-03-01 15:49:13.382895) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] 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=df17445c3590ff7897617a0e00000225-1488406134.439901-982370674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:49:13 INFO - MultiFileLogger online at 20170301 15:49:13 in /builds/slave/test 15:49:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:49:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:49:13 INFO - {'append_to_log': False, 15:49:13 INFO - 'base_work_dir': '/builds/slave/test', 15:49:13 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:49:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:49:13 INFO - 'branch': 'Mozilla-Beta', 15:49:13 INFO - 'buildbot_json_path': 'buildprops.json', 15:49:13 INFO - 'config_files': ('talos/linux_config.py',), 15:49:13 INFO - 'default_actions': ('clobber', 15:49:13 INFO - 'read-buildbot-config', 15:49:13 INFO - 'download-and-extract', 15:49:13 INFO - 'populate-webroot', 15:49:13 INFO - 'create-virtualenv', 15:49:13 INFO - 'install', 15:49:13 INFO - 'run-tests'), 15:49:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:49:13 INFO - 'download_minidump_stackwalk': True, 15:49:13 INFO - 'download_symbols': 'ondemand', 15:49:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:49:13 INFO - 'tooltool.py': '/tools/tooltool.py', 15:49:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:49:13 INFO - '/tools/misc-python/virtualenv.py')}, 15:49:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:49:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:49:13 INFO - 'installer_path': 'installer.exe', 15:49:13 INFO - 'log_level': 'info', 15:49:13 INFO - 'log_name': 'talos', 15:49:13 INFO - 'log_to_console': True, 15:49:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:49:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:49:13 INFO - 'opt_config_files': (), 15:49:13 INFO - 'pip_index': False, 15:49:13 INFO - 'sps_profile': False, 15:49:13 INFO - 'sps_profile_interval': 0, 15:49:13 INFO - 'suite': 'dromaeojs', 15:49:13 INFO - 'system_bits': '32', 15:49:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:49:13 INFO - 'title': 'talos-linux64-ix-021', 15:49:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:49:13 INFO - 'use_talos_json': True, 15:49:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:49:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:49:13 INFO - 'work_dir': 'build'} 15:49:13 INFO - [mozharness: 2017-03-01 23:49:13.705865Z] Running clobber step. 15:49:13 INFO - Running pre-action listener: _resource_record_pre_action 15:49:13 INFO - Running main action method: clobber 15:49:13 INFO - rmtree: /builds/slave/test/build 15:49:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:49:14 INFO - Running post-action listener: _resource_record_post_action 15:49:14 INFO - [mozharness: 2017-03-01 23:49:14.625774Z] Finished clobber step (success) 15:49:14 INFO - [mozharness: 2017-03-01 23:49:14.625872Z] Running read-buildbot-config step. 15:49:14 INFO - Running pre-action listener: _resource_record_pre_action 15:49:14 INFO - Running main action method: read_buildbot_config 15:49:14 INFO - Using buildbot properties: 15:49:14 INFO - { 15:49:14 INFO - "project": "", 15:49:14 INFO - "product": "firefox", 15:49:14 INFO - "script_repo_revision": "production", 15:49:14 INFO - "builddir": "mozilla-beta_ubuntu64_hw_test-dromaeojs", 15:49:14 INFO - "repository": "", 15:49:14 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-beta pgo talos dromaeojs", 15:49:14 INFO - "buildid": "20170301133922", 15:49:14 INFO - "pgo_build": "True", 15:49:14 INFO - "basedir": "/builds/slave/test", 15:49:14 INFO - "buildnumber": 34, 15:49:14 INFO - "slavename": "talos-linux64-ix-021", 15:49:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:49:14 INFO - "platform": "ubuntu64_hw", 15:49:14 INFO - "scheduler": "tests-mozilla-beta-linux64-pgo-talos", 15:49:14 INFO - "branch": "mozilla-beta", 15:49:14 INFO - "repo_path": "releases/mozilla-beta", 15:49:14 INFO - "revision": "d1b4c5e38c8fabe11d2b9e9fb79441e53d568381", 15:49:14 INFO - "stage_platform": "linux64-pgo", 15:49:14 INFO - "builduid": "b67885b8f9e94199842d821a6b095c0f", 15:49:14 INFO - "slavebuilddir": "test" 15:49:14 INFO - } 15:49:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/fUrovAjkRRC2WGtUulPscQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2. 15:49:14 INFO - Running post-action listener: _resource_record_post_action 15:49:14 INFO - [mozharness: 2017-03-01 23:49:14.628285Z] Finished read-buildbot-config step (success) 15:49:14 INFO - [mozharness: 2017-03-01 23:49:14.628373Z] Running download-and-extract step. 15:49:14 INFO - Running pre-action listener: _resource_record_pre_action 15:49:14 INFO - Running main action method: download_and_extract 15:49:14 INFO - mkdir: /builds/slave/test/build/tests 15:49:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:14 INFO - trying https://queue.taskcluster.net/v1/task/fUrovAjkRRC2WGtUulPscQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 15:49:14 INFO - Downloading https://queue.taskcluster.net/v1/task/fUrovAjkRRC2WGtUulPscQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 15:49:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fUrovAjkRRC2WGtUulPscQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:49:15 INFO - Downloaded 1327 bytes. 15:49:15 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.test_packages.json 15:49:15 INFO - Using the following test package requirements: 15:49:15 INFO - {u'common': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 15:49:15 INFO - u'cppunittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 15:49:15 INFO - u'firefox-52.0.en-US.linux-x86_64.cppunittest.tests.zip'], 15:49:15 INFO - u'gtest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 15:49:15 INFO - u'firefox-52.0.en-US.linux-x86_64.gtest.tests.zip'], 15:49:15 INFO - u'jittest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 15:49:15 INFO - u'jsshell-linux-x86_64.zip'], 15:49:15 INFO - u'mochitest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 15:49:15 INFO - u'firefox-52.0.en-US.linux-x86_64.mochitest.tests.zip'], 15:49:15 INFO - u'mozbase': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'], 15:49:15 INFO - u'reftest': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 15:49:15 INFO - u'firefox-52.0.en-US.linux-x86_64.reftest.tests.zip'], 15:49:15 INFO - u'talos': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 15:49:15 INFO - u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'], 15:49:15 INFO - u'web-platform': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 15:49:15 INFO - u'firefox-52.0.en-US.linux-x86_64.web-platform.tests.zip'], 15:49:15 INFO - u'xpcshell': [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', 15:49:15 INFO - u'firefox-52.0.en-US.linux-x86_64.xpcshell.tests.zip']} 15:49:15 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:49:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fUrovAjkRRC2WGtUulPscQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 15:49:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fUrovAjkRRC2WGtUulPscQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:49:15 INFO - Fetch https://queue.taskcluster.net/v1/task/fUrovAjkRRC2WGtUulPscQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 15:49:15 INFO - Http code: 200 15:49:15 INFO - via: 1.1 23172d761378a3865feafcda78328053.cloudfront.net (CloudFront) 15:49:15 INFO - x-amz-cf-id: F2Xo4bOd8FmqgOQb29QyT3EzopGh-5Avut5ODQpgN9Aj1_Z61kYFSg== 15:49:15 INFO - x-amz-version-id: 3PQSzlnQ2DUMj8pmRkeTJP7hrrvu7lmz 15:49:16 INFO - Expected file size: 21963572 15:49:16 INFO - Obtained file size: 21963572 15:49:20 INFO - Downloading packages: [u'firefox-52.0.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:49:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fUrovAjkRRC2WGtUulPscQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip 15:49:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fUrovAjkRRC2WGtUulPscQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:49:20 INFO - Fetch https://queue.taskcluster.net/v1/task/fUrovAjkRRC2WGtUulPscQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.common.tests.zip into memory 15:49:20 INFO - Http code: 200 15:49:20 INFO - via: 1.1 8008015354a3ca72f56c382a1d1cfe9f.cloudfront.net (CloudFront) 15:49:20 INFO - x-amz-cf-id: vy9e3Z-YETS-dwqTnyCxWO0zra8emiuPDWOOpjHB8J8GLfQgP7fL1A== 15:49:20 INFO - x-amz-version-id: 3PQSzlnQ2DUMj8pmRkeTJP7hrrvu7lmz 15:49:21 INFO - Expected file size: 21963572 15:49:21 INFO - Obtained file size: 21963572 15:49:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fUrovAjkRRC2WGtUulPscQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip 15:49:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fUrovAjkRRC2WGtUulPscQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:49:25 INFO - Fetch https://queue.taskcluster.net/v1/task/fUrovAjkRRC2WGtUulPscQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.talos.tests.zip into memory 15:49:26 INFO - Http code: 200 15:49:26 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 15:49:26 INFO - x-amz-cf-id: 1luJdibY-WWn5djYYji_Wwpf4dBKBZG_KppAfDRfIj6SxIU-aig15A== 15:49:26 INFO - x-amz-version-id: S1iL1yrHDEHyaJGMzOVktPKwMaFaeel_ 15:49:26 INFO - Expected file size: 14402992 15:49:26 INFO - Obtained file size: 14402992 15:49:26 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')]} 15:49:26 INFO - trying https://queue.taskcluster.net/v1/task/fUrovAjkRRC2WGtUulPscQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 15:49:26 INFO - Downloading https://queue.taskcluster.net/v1/task/fUrovAjkRRC2WGtUulPscQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 15:49:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fUrovAjkRRC2WGtUulPscQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:49:27 INFO - Downloaded 57740719 bytes. 15:49:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fUrovAjkRRC2WGtUulPscQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 15:49:27 INFO - mkdir: /builds/slave/test/properties 15:49:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:49:27 INFO - Writing to file /builds/slave/test/properties/build_url 15:49:27 INFO - Contents: 15:49:27 INFO - build_url:https://queue.taskcluster.net/v1/task/fUrovAjkRRC2WGtUulPscQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 15:49:28 INFO - Running post-action listener: _resource_record_post_action 15:49:28 INFO - Running post-action listener: set_extra_try_arguments 15:49:28 INFO - [mozharness: 2017-03-01 23:49:28.265918Z] Finished download-and-extract step (success) 15:49:28 INFO - [mozharness: 2017-03-01 23:49:28.266143Z] Running populate-webroot step. 15:49:28 INFO - Running pre-action listener: _resource_record_pre_action 15:49:28 INFO - Running main action method: populate_webroot 15:49:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:49:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:49:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:49:28 INFO - '--tppagecycles', 15:49:28 INFO - '7'], 15:49:28 INFO - 'tests': ['tsvgm']}}, 15:49:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:49:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:49:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:49:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:49:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:49:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:49:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:28 INFO - 'talos_options': ['--disable-e10s'], 15:49:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:49:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:49:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:28 INFO - 'talos_options': ['--disable-e10s'], 15:49:28 INFO - 'tests': ['damp', 'tps']}, 15:49:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:28 INFO - 'tests': ['damp', 'tps']}, 15:49:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:49:28 INFO - 'tests': ['dromaeo_dom']}, 15:49:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:49:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:49:28 INFO - 'tests': ['basic_compositor_video']}, 15:49:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:49:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:49:28 INFO - 'tests': ['a11yr', 15:49:28 INFO - 'ts_paint', 15:49:28 INFO - 'tpaint', 15:49:28 INFO - 'sessionrestore', 15:49:28 INFO - 'sessionrestore_no_auto_restore', 15:49:28 INFO - 'tabpaint']}, 15:49:28 INFO - 'other-e10s': {'tests': ['a11yr', 15:49:28 INFO - 'ts_paint', 15:49:28 INFO - 'tpaint', 15:49:28 INFO - 'sessionrestore', 15:49:28 INFO - 'sessionrestore_no_auto_restore', 15:49:28 INFO - 'tabpaint']}, 15:49:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:49:28 INFO - 'ts_paint', 15:49:28 INFO - 'tpaint', 15:49:28 INFO - 'sessionrestore', 15:49:28 INFO - 'sessionrestore_no_auto_restore', 15:49:28 INFO - 'tabpaint']}, 15:49:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:49:28 INFO - 'ts_paint', 15:49:28 INFO - 'tpaint', 15:49:28 INFO - 'sessionrestore', 15:49:28 INFO - 'sessionrestore_no_auto_restore', 15:49:28 INFO - 'tabpaint']}, 15:49:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:49:28 INFO - 'tests': ['a11yr', 15:49:28 INFO - 'ts_paint', 15:49:28 INFO - 'tpaint', 15:49:28 INFO - 'sessionrestore', 15:49:28 INFO - 'sessionrestore_no_auto_restore', 15:49:28 INFO - 'tabpaint']}, 15:49:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:49:28 INFO - 'tests': ['a11yr', 15:49:28 INFO - 'ts_paint', 15:49:28 INFO - 'tpaint', 15:49:28 INFO - 'sessionrestore', 15:49:28 INFO - 'sessionrestore_no_auto_restore', 15:49:28 INFO - 'tabpaint']}, 15:49:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:49:28 INFO - 'tests': ['tsvgx', 15:49:28 INFO - 'tsvgr_opacity', 15:49:28 INFO - 'tart', 15:49:28 INFO - 'tscrollx', 15:49:28 INFO - 'cart']}, 15:49:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:49:28 INFO - 'tsvgr_opacity', 15:49:28 INFO - 'tart', 15:49:28 INFO - 'tscrollx', 15:49:28 INFO - 'cart']}, 15:49:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:28 INFO - 'talos_options': ['--disable-e10s'], 15:49:28 INFO - 'tests': ['tp5o']}, 15:49:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:28 INFO - 'tests': ['tp5o']}, 15:49:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:28 INFO - 'talos_options': ['--disable-e10s', 15:49:28 INFO - '--xperf_path', 15:49:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:49:28 INFO - 'tests': ['tp5n']}, 15:49:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:49:28 INFO - 'talos_options': ['--xperf_path', 15:49:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:49:28 INFO - 'tests': ['tp5n']}}, 15:49:28 INFO - 'talos.zip': {'path': '', 15:49:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:49:28 INFO - Running post-action listener: _resource_record_post_action 15:49:28 INFO - [mozharness: 2017-03-01 23:49:28.288596Z] Finished populate-webroot step (success) 15:49:28 INFO - [mozharness: 2017-03-01 23:49:28.288683Z] Running create-virtualenv step. 15:49:28 INFO - Running pre-action listener: _resource_record_pre_action 15:49:28 INFO - Running main action method: create_virtualenv 15:49:28 INFO - Creating virtualenv /builds/slave/test/build/venv 15:49:28 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 15:49:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:49:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:49:28 INFO - Using real prefix '/usr' 15:49:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:49:28 INFO - Installing distribute.............................................................................................................................................................................................done. 15:49:30 INFO - Installing pip.................done. 15:49:30 INFO - Return code: 0 15:49:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:49:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:49:31 INFO - Reading from file tmpfile_stdout 15:49:31 INFO - Output received: 15:49:31 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) 15:49:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:49:31 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')]} 15:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:31 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')]} 15:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:31 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 0x7f53573c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a93ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a90f60>, '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 0x1a91d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a921d0>, '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': 'df17445c3590ff7897617a0e00000225-1488406134.439901-982370674', '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 15:49:31 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 15:49:31 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 15:49:31 INFO - Using env: {'DISPLAY': ':0', 15:49:31 INFO - 'HOME': '/home/cltbld', 15:49:31 INFO - 'LANG': 'en_US.UTF-8', 15:49:31 INFO - 'LANGUAGE': 'en_US:en', 15:49:31 INFO - 'LOGNAME': 'cltbld', 15:49:31 INFO - 'MAIL': '/var/mail/cltbld', 15:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:31 INFO - 'MOZ_NO_REMOTE': '1', 15:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:31 INFO - 'NO_EM_RESTART': '1', 15:49:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:31 INFO - 'PWD': '/builds/slave/test', 15:49:31 INFO - 'SHELL': '/bin/bash', 15:49:31 INFO - 'SHLVL': '1', 15:49:31 INFO - 'TERM': 'linux', 15:49:31 INFO - 'TMOUT': '86400', 15:49:31 INFO - 'USER': 'cltbld', 15:49:31 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1488406134.439901-982370674', 15:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:31 INFO - '_': '/tools/buildbot/bin/python'} 15:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:31 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 15:49:31 INFO - Cleaning up... 15:49:31 INFO - Return code: 0 15:49:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:49:31 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')]} 15:49:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:31 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')]} 15:49:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:31 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 0x7f53573c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a93ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a90f60>, '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 0x1a91d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a921d0>, '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': 'df17445c3590ff7897617a0e00000225-1488406134.439901-982370674', '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 15:49:31 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 15:49:31 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 15:49:31 INFO - Using env: {'DISPLAY': ':0', 15:49:31 INFO - 'HOME': '/home/cltbld', 15:49:31 INFO - 'LANG': 'en_US.UTF-8', 15:49:31 INFO - 'LANGUAGE': 'en_US:en', 15:49:31 INFO - 'LOGNAME': 'cltbld', 15:49:31 INFO - 'MAIL': '/var/mail/cltbld', 15:49:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:31 INFO - 'MOZ_NO_REMOTE': '1', 15:49:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:31 INFO - 'NO_EM_RESTART': '1', 15:49:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:31 INFO - 'PWD': '/builds/slave/test', 15:49:31 INFO - 'SHELL': '/bin/bash', 15:49:31 INFO - 'SHLVL': '1', 15:49:31 INFO - 'TERM': 'linux', 15:49:31 INFO - 'TMOUT': '86400', 15:49:31 INFO - 'USER': 'cltbld', 15:49:31 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1488406134.439901-982370674', 15:49:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:31 INFO - '_': '/tools/buildbot/bin/python'} 15:49:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:31 INFO - Downloading/unpacking psutil>=3.1.1 15:49:31 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 15:49:31 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 15:49:31 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 15:49:31 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 15:49:31 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 15:49:31 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 15:49:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:49:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:49:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:49:33 INFO - Installing collected packages: psutil 15:49:33 INFO - Running setup.py install for psutil 15:49:33 INFO - building 'psutil._psutil_linux' extension 15:49:33 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 15:49:33 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 15:49:33 INFO - building 'psutil._psutil_posix' extension 15:49:33 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 15:49:34 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 15:49:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:49:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:49:34 INFO - Successfully installed psutil 15:49:34 INFO - Cleaning up... 15:49:34 INFO - Return code: 0 15:49:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:49: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')]} 15:49:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49: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')]} 15:49:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:34 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 0x7f53573c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a93ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a90f60>, '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 0x1a91d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a921d0>, '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': 'df17445c3590ff7897617a0e00000225-1488406134.439901-982370674', '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 15:49:34 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 15:49:34 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 15:49:34 INFO - Using env: {'DISPLAY': ':0', 15:49:34 INFO - 'HOME': '/home/cltbld', 15:49:34 INFO - 'LANG': 'en_US.UTF-8', 15:49:34 INFO - 'LANGUAGE': 'en_US:en', 15:49:34 INFO - 'LOGNAME': 'cltbld', 15:49:34 INFO - 'MAIL': '/var/mail/cltbld', 15:49:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:34 INFO - 'MOZ_NO_REMOTE': '1', 15:49:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:34 INFO - 'NO_EM_RESTART': '1', 15:49:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:34 INFO - 'PWD': '/builds/slave/test', 15:49:34 INFO - 'SHELL': '/bin/bash', 15:49:34 INFO - 'SHLVL': '1', 15:49:34 INFO - 'TERM': 'linux', 15:49:34 INFO - 'TMOUT': '86400', 15:49:34 INFO - 'USER': 'cltbld', 15:49:34 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1488406134.439901-982370674', 15:49:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:34 INFO - '_': '/tools/buildbot/bin/python'} 15:49:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:49:34 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 15:49:34 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 15:49:34 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 15:49:34 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 15:49:34 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 15:49:34 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 15:49:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:49:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:49:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:49:36 INFO - Installing collected packages: mozsystemmonitor 15:49:36 INFO - Running setup.py install for mozsystemmonitor 15:49:36 INFO - Successfully installed mozsystemmonitor 15:49:36 INFO - Cleaning up... 15:49:36 INFO - Return code: 0 15:49:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:36 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 0x7f53573c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a93ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a90f60>, '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 0x1a91d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a921d0>, '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': 'df17445c3590ff7897617a0e00000225-1488406134.439901-982370674', '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 15:49:36 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 15:49:36 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 15:49:36 INFO - Using env: {'DISPLAY': ':0', 15:49:36 INFO - 'HOME': '/home/cltbld', 15:49:36 INFO - 'LANG': 'en_US.UTF-8', 15:49:36 INFO - 'LANGUAGE': 'en_US:en', 15:49:36 INFO - 'LOGNAME': 'cltbld', 15:49:36 INFO - 'MAIL': '/var/mail/cltbld', 15:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:36 INFO - 'MOZ_NO_REMOTE': '1', 15:49:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:36 INFO - 'NO_EM_RESTART': '1', 15:49:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:36 INFO - 'PWD': '/builds/slave/test', 15:49:36 INFO - 'SHELL': '/bin/bash', 15:49:36 INFO - 'SHLVL': '1', 15:49:36 INFO - 'TERM': 'linux', 15:49:36 INFO - 'TMOUT': '86400', 15:49:36 INFO - 'USER': 'cltbld', 15:49:36 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1488406134.439901-982370674', 15:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:36 INFO - '_': '/tools/buildbot/bin/python'} 15:49:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:36 INFO - Downloading/unpacking jsonschema==2.5.1 15:49:36 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 15:49:36 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 15:49:36 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 15:49:36 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 15:49:36 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 15:49:36 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 15:49:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:49:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:49: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 15:49: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 15:49: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 15:49: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 15:49: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 15:49: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 15:49:39 INFO - Downloading functools32-3.2.3-2.tar.gz 15:49:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:49:39 INFO - warning: no files found matching '*.txt' 15:49:39 INFO - no previously-included directories found matching 'build' 15:49:39 INFO - no previously-included directories found matching 'dist' 15:49:39 INFO - no previously-included directories found matching '.git*' 15:49:39 INFO - Installing collected packages: jsonschema, functools32 15:49:39 INFO - Running setup.py install for functools32 15:49:39 INFO - warning: no files found matching '*.txt' 15:49:39 INFO - no previously-included directories found matching 'build' 15:49:39 INFO - no previously-included directories found matching 'dist' 15:49:39 INFO - no previously-included directories found matching '.git*' 15:49:39 INFO - Successfully installed jsonschema functools32 15:49:39 INFO - Cleaning up... 15:49:39 INFO - Return code: 0 15:49:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:39 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 0x7f53573c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a93ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a90f60>, '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 0x1a91d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a921d0>, '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': 'df17445c3590ff7897617a0e00000225-1488406134.439901-982370674', '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 15:49:39 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 15:49:39 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 15:49:39 INFO - Using env: {'DISPLAY': ':0', 15:49:39 INFO - 'HOME': '/home/cltbld', 15:49:39 INFO - 'LANG': 'en_US.UTF-8', 15:49:39 INFO - 'LANGUAGE': 'en_US:en', 15:49:39 INFO - 'LOGNAME': 'cltbld', 15:49:39 INFO - 'MAIL': '/var/mail/cltbld', 15:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:39 INFO - 'MOZ_NO_REMOTE': '1', 15:49:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:39 INFO - 'NO_EM_RESTART': '1', 15:49:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:39 INFO - 'PWD': '/builds/slave/test', 15:49:39 INFO - 'SHELL': '/bin/bash', 15:49:39 INFO - 'SHLVL': '1', 15:49:39 INFO - 'TERM': 'linux', 15:49:39 INFO - 'TMOUT': '86400', 15:49:39 INFO - 'USER': 'cltbld', 15:49:39 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1488406134.439901-982370674', 15:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:39 INFO - '_': '/tools/buildbot/bin/python'} 15:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:49:39 INFO - Cleaning up... 15:49:39 INFO - Return code: 0 15:49:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:39 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 0x7f53573c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a93ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a90f60>, '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 0x1a91d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a921d0>, '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': 'df17445c3590ff7897617a0e00000225-1488406134.439901-982370674', '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 15:49:39 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 15:49:39 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 15:49:39 INFO - Using env: {'DISPLAY': ':0', 15:49:39 INFO - 'HOME': '/home/cltbld', 15:49:39 INFO - 'LANG': 'en_US.UTF-8', 15:49:39 INFO - 'LANGUAGE': 'en_US:en', 15:49:39 INFO - 'LOGNAME': 'cltbld', 15:49:39 INFO - 'MAIL': '/var/mail/cltbld', 15:49:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:39 INFO - 'MOZ_NO_REMOTE': '1', 15:49:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:39 INFO - 'NO_EM_RESTART': '1', 15:49:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:39 INFO - 'PWD': '/builds/slave/test', 15:49:39 INFO - 'SHELL': '/bin/bash', 15:49:39 INFO - 'SHLVL': '1', 15:49:39 INFO - 'TERM': 'linux', 15:49:39 INFO - 'TMOUT': '86400', 15:49:39 INFO - 'USER': 'cltbld', 15:49:39 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1488406134.439901-982370674', 15:49:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:39 INFO - '_': '/tools/buildbot/bin/python'} 15:49:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:39 INFO - Downloading/unpacking blobuploader==1.2.4 15:49:39 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 15:49:39 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 15:49:39 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 15:49:39 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 15:49:39 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 15:49:39 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 15:49:41 INFO - Downloading blobuploader-1.2.4.tar.gz 15:49:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:49:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:49:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:49:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:49:42 INFO - Downloading docopt-0.6.1.tar.gz 15:49:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:49:42 INFO - Installing collected packages: blobuploader, requests, docopt 15:49:42 INFO - Running setup.py install for blobuploader 15:49:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:49:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:49:42 INFO - Running setup.py install for requests 15:49:43 INFO - Running setup.py install for docopt 15:49:43 INFO - Successfully installed blobuploader requests docopt 15:49:43 INFO - Cleaning up... 15:49:43 INFO - Return code: 0 15:49:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:43 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 0x7f53573c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a93ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a90f60>, '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 0x1a91d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a921d0>, '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': 'df17445c3590ff7897617a0e00000225-1488406134.439901-982370674', '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 15:49:43 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 15:49:43 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 15:49:43 INFO - Using env: {'DISPLAY': ':0', 15:49:43 INFO - 'HOME': '/home/cltbld', 15:49:43 INFO - 'LANG': 'en_US.UTF-8', 15:49:43 INFO - 'LANGUAGE': 'en_US:en', 15:49:43 INFO - 'LOGNAME': 'cltbld', 15:49:43 INFO - 'MAIL': '/var/mail/cltbld', 15:49:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:43 INFO - 'MOZ_NO_REMOTE': '1', 15:49:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:43 INFO - 'NO_EM_RESTART': '1', 15:49:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:43 INFO - 'PWD': '/builds/slave/test', 15:49:43 INFO - 'SHELL': '/bin/bash', 15:49:43 INFO - 'SHLVL': '1', 15:49:43 INFO - 'TERM': 'linux', 15:49:43 INFO - 'TMOUT': '86400', 15:49:43 INFO - 'USER': 'cltbld', 15:49:43 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1488406134.439901-982370674', 15:49:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:43 INFO - '_': '/tools/buildbot/bin/python'} 15:49:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:49:43 INFO - Running setup.py (path:/tmp/pip-U9aSw6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:49:43 INFO - Running setup.py (path:/tmp/pip-fTmokB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:49:43 INFO - Running setup.py (path:/tmp/pip-_i1wjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:49:43 INFO - Running setup.py (path:/tmp/pip-s0zAGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:49:43 INFO - Running setup.py (path:/tmp/pip-062pL6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:49:43 INFO - Running setup.py (path:/tmp/pip-QeDN3Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:49:43 INFO - Running setup.py (path:/tmp/pip-nNbjA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:49:43 INFO - Running setup.py (path:/tmp/pip-nNxHTl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:49:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:49:43 INFO - Running setup.py (path:/tmp/pip-GqAEpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:49:44 INFO - Running setup.py (path:/tmp/pip-5Lm34n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:49:44 INFO - Running setup.py (path:/tmp/pip-od1ESA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:49:44 INFO - Running setup.py (path:/tmp/pip-o_LOq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:49:44 INFO - Running setup.py (path:/tmp/pip-0g7KbO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:49:44 INFO - Running setup.py (path:/tmp/pip-75rf4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:44 INFO - Running setup.py (path:/tmp/pip-BXvgYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:49:44 INFO - Running setup.py (path:/tmp/pip-SOgbCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:49:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:49:44 INFO - Running setup.py (path:/tmp/pip-mL0EgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:49:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:49:44 INFO - Running setup.py install for manifestparser 15:49:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:49:44 INFO - Running setup.py install for mozcrash 15:49:44 INFO - Running setup.py install for mozdebug 15:49:44 INFO - Running setup.py install for mozdevice 15:49:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:49:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:49:45 INFO - Running setup.py install for mozfile 15:49:45 INFO - Running setup.py install for mozhttpd 15:49:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:49:45 INFO - Running setup.py install for mozinfo 15:49:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:49:45 INFO - Running setup.py install for mozInstall 15:49:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:49:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:49:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:49:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:49:45 INFO - Running setup.py install for mozleak 15:49:45 INFO - Running setup.py install for mozlog 15:49:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:49:45 INFO - Running setup.py install for moznetwork 15:49:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:49:45 INFO - Running setup.py install for mozprocess 15:49:45 INFO - Running setup.py install for mozprofile 15:49:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:49:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:49:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:49:45 INFO - Running setup.py install for mozrunner 15:49:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:49:46 INFO - Running setup.py install for mozscreenshot 15:49:46 INFO - Running setup.py install for moztest 15:49:46 INFO - Running setup.py install for mozversion 15:49:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:49:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:49:46 INFO - Cleaning up... 15:49:46 INFO - Return code: 0 15:49:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:46 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 0x7f53573c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a93ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a90f60>, '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 0x1a91d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a921d0>, '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': 'df17445c3590ff7897617a0e00000225-1488406134.439901-982370674', '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 15:49:46 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 15:49:46 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 15:49:46 INFO - Using env: {'DISPLAY': ':0', 15:49:46 INFO - 'HOME': '/home/cltbld', 15:49:46 INFO - 'LANG': 'en_US.UTF-8', 15:49:46 INFO - 'LANGUAGE': 'en_US:en', 15:49:46 INFO - 'LOGNAME': 'cltbld', 15:49:46 INFO - 'MAIL': '/var/mail/cltbld', 15:49:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:46 INFO - 'MOZ_NO_REMOTE': '1', 15:49:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:46 INFO - 'NO_EM_RESTART': '1', 15:49:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:46 INFO - 'PWD': '/builds/slave/test', 15:49:46 INFO - 'SHELL': '/bin/bash', 15:49:46 INFO - 'SHLVL': '1', 15:49:46 INFO - 'TERM': 'linux', 15:49:46 INFO - 'TMOUT': '86400', 15:49:46 INFO - 'USER': 'cltbld', 15:49:46 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1488406134.439901-982370674', 15:49:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:46 INFO - '_': '/tools/buildbot/bin/python'} 15:49:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:49:46 INFO - Running setup.py (path:/tmp/pip-Rd2bZl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:49:46 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)) 15:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:49:46 INFO - Running setup.py (path:/tmp/pip-IdcBLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:49:46 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)) 15:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:49:46 INFO - Running setup.py (path:/tmp/pip-IJC1jf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:49:46 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)) 15:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:49:46 INFO - Running setup.py (path:/tmp/pip-icdqep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:49:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 15:49:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:49:46 INFO - Running setup.py (path:/tmp/pip-zvG2AZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:49:47 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)) 15:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:49:47 INFO - Running setup.py (path:/tmp/pip-m1Zvmd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:49:47 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)) 15:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:49:47 INFO - Running setup.py (path:/tmp/pip-4qoJL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:49:47 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)) 15:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:49:47 INFO - Running setup.py (path:/tmp/pip-AMDu4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:49:47 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)) 15:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:49:47 INFO - Running setup.py (path:/tmp/pip-1KCtqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:49:47 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)) 15:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:49:47 INFO - Running setup.py (path:/tmp/pip-hJDJ5m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:49:47 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)) 15:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:49:47 INFO - Running setup.py (path:/tmp/pip-V6GCjB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:49:47 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)) 15:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:49:47 INFO - Running setup.py (path:/tmp/pip-Edn4Ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:49:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 15:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:49:47 INFO - Running setup.py (path:/tmp/pip-OPohLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:49:47 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)) 15:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:49:47 INFO - Running setup.py (path:/tmp/pip-oORGif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:49:47 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)) 15:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:47 INFO - Running setup.py (path:/tmp/pip-0JqHeG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:49:47 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)) 15:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:49:47 INFO - Running setup.py (path:/tmp/pip-f_79kE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:49:47 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)) 15:49:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:49:47 INFO - Running setup.py (path:/tmp/pip-44pvIi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:49:47 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)) 15:49:47 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)) 15:49:47 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)) 15:49:47 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)) 15:49:47 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:49:47 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:49:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:49:47 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 15:49:47 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 15:49:47 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 15:49:47 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 15:49:47 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 15:49:47 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 15:49:49 INFO - Downloading blessings-1.6.tar.gz 15:49:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:49:50 INFO - Installing collected packages: blessings 15:49:50 INFO - Running setup.py install for blessings 15:49:50 INFO - Successfully installed blessings 15:49:50 INFO - Cleaning up... 15:49:50 INFO - Return code: 0 15:49:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:49:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:50 INFO - Reading from file tmpfile_stdout 15:49:50 INFO - Current package versions: 15:49:50 INFO - argparse == 1.2.1 15:49:50 INFO - blessings == 1.6 15:49:50 INFO - blobuploader == 1.2.4 15:49:50 INFO - docopt == 0.6.1 15:49:50 INFO - functools32 == 3.2.3-2 15:49:50 INFO - jsonschema == 2.5.1 15:49:50 INFO - manifestparser == 1.1 15:49:50 INFO - mozInstall == 1.12 15:49:50 INFO - mozcrash == 1.0 15:49:50 INFO - mozdebug == 0.1 15:49:50 INFO - mozdevice == 0.48 15:49:50 INFO - mozfile == 1.2 15:49:50 INFO - mozhttpd == 0.7 15:49:50 INFO - mozinfo == 0.9 15:49:50 INFO - mozleak == 0.1 15:49:50 INFO - mozlog == 3.4 15:49:50 INFO - moznetwork == 0.27 15:49:50 INFO - mozprocess == 0.23 15:49:50 INFO - mozprofile == 0.28 15:49:50 INFO - mozrunner == 6.13 15:49:50 INFO - mozscreenshot == 0.1 15:49:50 INFO - mozsystemmonitor == 0.3 15:49:50 INFO - moztest == 0.8 15:49:50 INFO - mozversion == 1.4 15:49:50 INFO - psutil == 3.1.1 15:49:50 INFO - requests == 1.2.3 15:49:50 INFO - wsgiref == 0.1.2 15:49:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:50 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 0x7f53573c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a93ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a90f60>, '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 0x1a91d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a921d0>, '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': 'df17445c3590ff7897617a0e00000225-1488406134.439901-982370674', '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 15:49:50 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 15:49:50 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 15:49:50 INFO - Using env: {'DISPLAY': ':0', 15:49:50 INFO - 'HOME': '/home/cltbld', 15:49:50 INFO - 'LANG': 'en_US.UTF-8', 15:49:50 INFO - 'LANGUAGE': 'en_US:en', 15:49:50 INFO - 'LOGNAME': 'cltbld', 15:49:50 INFO - 'MAIL': '/var/mail/cltbld', 15:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:50 INFO - 'MOZ_NO_REMOTE': '1', 15:49:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:50 INFO - 'NO_EM_RESTART': '1', 15:49:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:50 INFO - 'PWD': '/builds/slave/test', 15:49:50 INFO - 'SHELL': '/bin/bash', 15:49:50 INFO - 'SHLVL': '1', 15:49:50 INFO - 'TERM': 'linux', 15:49:50 INFO - 'TMOUT': '86400', 15:49:50 INFO - 'USER': 'cltbld', 15:49:50 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1488406134.439901-982370674', 15:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:50 INFO - '_': '/tools/buildbot/bin/python'} 15:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:50 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)) 15:49:50 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)) 15:49:50 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)) 15:49:50 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)) 15:49:50 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)) 15:49:50 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)) 15:49:50 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)) 15:49:50 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)) 15:49:50 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)) 15:49:50 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)) 15:49:50 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)) 15:49:50 INFO - Cleaning up... 15:49:50 INFO - Return code: 0 15:49:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:49:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:49:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:49:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f53573c9f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19c68a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a93ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a90f60>, '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 0x1a91d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a921d0>, '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': 'df17445c3590ff7897617a0e00000225-1488406134.439901-982370674', '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 15:49:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:49:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:49:50 INFO - Using env: {'DISPLAY': ':0', 15:49:50 INFO - 'HOME': '/home/cltbld', 15:49:50 INFO - 'LANG': 'en_US.UTF-8', 15:49:50 INFO - 'LANGUAGE': 'en_US:en', 15:49:50 INFO - 'LOGNAME': 'cltbld', 15:49:50 INFO - 'MAIL': '/var/mail/cltbld', 15:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:49:50 INFO - 'MOZ_NO_REMOTE': '1', 15:49:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:49:50 INFO - 'NO_EM_RESTART': '1', 15:49:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:49:50 INFO - 'PWD': '/builds/slave/test', 15:49:50 INFO - 'SHELL': '/bin/bash', 15:49:50 INFO - 'SHLVL': '1', 15:49:50 INFO - 'TERM': 'linux', 15:49:50 INFO - 'TMOUT': '86400', 15:49:50 INFO - 'USER': 'cltbld', 15:49:50 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1488406134.439901-982370674', 15:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:49:50 INFO - '_': '/tools/buildbot/bin/python'} 15:49:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:49:50 INFO - Cleaning up... 15:49:50 INFO - Return code: 0 15:49:50 INFO - Running post-action listener: _resource_record_post_action 15:49:50 INFO - Running post-action listener: _start_resource_monitoring 15:49:50 INFO - Starting resource monitoring. 15:49:50 INFO - [mozharness: 2017-03-01 23:49:50.901611Z] Finished create-virtualenv step (success) 15:49:50 INFO - [mozharness: 2017-03-01 23:49:50.902072Z] Running install step. 15:49:50 INFO - Running pre-action listener: _resource_record_pre_action 15:49:50 INFO - Running main action method: install 15:49:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:49:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:49:51 INFO - Reading from file tmpfile_stdout 15:49:51 INFO - Detecting whether we're running mozinstall >=1.0... 15:49:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:49:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:49:51 INFO - Reading from file tmpfile_stdout 15:49:51 INFO - Output received: 15:49:51 INFO - Usage: mozinstall [options] installer 15:49:51 INFO - Options: 15:49:51 INFO - -h, --help show this help message and exit 15:49:51 INFO - -d DEST, --destination=DEST 15:49:51 INFO - Directory to install application into. [default: 15:49:51 INFO - "/builds/slave/test"] 15:49:51 INFO - --app=APP Application being installed. [default: firefox] 15:49:51 INFO - mkdir: /builds/slave/test/build/application 15:49:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:49:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:50:04 INFO - Reading from file tmpfile_stdout 15:50:04 INFO - Output received: 15:50:04 INFO - /builds/slave/test/build/application/firefox/firefox 15:50:04 INFO - Running post-action listener: _resource_record_post_action 15:50:04 INFO - [mozharness: 2017-03-01 23:50:04.838845Z] Finished install step (success) 15:50:04 INFO - [mozharness: 2017-03-01 23:50:04.839086Z] Running run-tests step. 15:50:04 INFO - Running pre-action listener: _resource_record_pre_action 15:50:04 INFO - Running main action method: run_tests 15:50:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:50:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:50:04 INFO - Python 2.7.3 15:50:04 INFO - Return code: 0 15:50:04 INFO - grabbing minidump binary from tooltool 15:50:04 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')]} 15:50:04 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 0x1a90f60>, '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 0x1a91d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a921d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:50:04 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 15:50:04 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 15:50:04 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 15:50:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:50:04 INFO - Return code: 0 15:50:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:50:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:50:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:50:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:50:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:50:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fUrovAjkRRC2WGtUulPscQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 15:50:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fUrovAjkRRC2WGtUulPscQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-021 --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 15:50:04 INFO - Using env: {'DISPLAY': ':0', 15:50:04 INFO - 'HOME': '/home/cltbld', 15:50:04 INFO - 'LANG': 'en_US.UTF-8', 15:50:04 INFO - 'LANGUAGE': 'en_US:en', 15:50:04 INFO - 'LOGNAME': 'cltbld', 15:50:04 INFO - 'MAIL': '/var/mail/cltbld', 15:50:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:50:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:50:04 INFO - 'MOZ_NO_REMOTE': '1', 15:50:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:50:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:50:04 INFO - 'NO_EM_RESTART': '1', 15:50:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:50:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:50:04 INFO - 'PWD': '/builds/slave/test', 15:50:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:50:04 INFO - 'SHELL': '/bin/bash', 15:50:04 INFO - 'SHLVL': '1', 15:50:04 INFO - 'TERM': 'linux', 15:50:04 INFO - 'TMOUT': '86400', 15:50:04 INFO - 'USER': 'cltbld', 15:50:04 INFO - 'XDG_SESSION_COOKIE': 'df17445c3590ff7897617a0e00000225-1488406134.439901-982370674', 15:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:50:04 INFO - '_': '/tools/buildbot/bin/python'} 15:50:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fUrovAjkRRC2WGtUulPscQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-021', '--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 15:50:05 INFO - mozversion application_buildid: 20170301133922 15:50:05 INFO - mozversion application_changeset: d1b4c5e38c8fabe11d2b9e9fb79441e53d568381 15:50:05 INFO - mozversion application_display_name: Firefox 15:50:05 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:50:05 INFO - mozversion application_name: Firefox 15:50:05 INFO - mozversion application_remotingname: firefox 15:50:05 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:50:05 INFO - mozversion application_vendor: Mozilla 15:50:05 INFO - mozversion application_version: 52.0 15:50:05 INFO - mozversion platform_buildid: 20170301133922 15:50:05 INFO - mozversion platform_changeset: d1b4c5e38c8fabe11d2b9e9fb79441e53d568381 15:50:05 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:50:05 INFO - mozversion platform_version: 52.0 15:50:05 INFO - using testdate: 1488412205 15:50:05 INFO - actual date: 1488412205 15:50:05 INFO - starting webserver on 'localhost:38321' 15:50:05 INFO - SUITE-START | Running 2 tests 15:50:05 INFO - TEST-START | dromaeo_css 15:50:05 INFO - operating with platform_type : linux_ 15:50:05 INFO - Initialising browser for dromaeo_css test... 15:50:05 INFO - TEST-INFO | started process 12435 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfWTBrN/profile http://localhost:38321/getInfo.html) 15:50:09 INFO - PROCESS | 12435 | __metrics Screen width/height:1600/1200 15:50:09 INFO - PROCESS | 12435 | colorDepth:24 15:50:09 INFO - PROCESS | 12435 | Browser inner width/height: 1024/697 15:50:09 INFO - PROCESS | 12435 | __metrics 15:50:10 INFO - PROCESS | 12435 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:50:10 INFO - PROCESS | 12435 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:50:11 INFO - TEST-INFO | 12435: exit 0 15:50:11 INFO - Browser initialized. 15:50:11 INFO - Running cycle 1/1 for dromaeo_css test... 15:50:11 INFO - TEST-INFO | started process 12528 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfWTBrN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:50:23 INFO - PROCESS | 12528 | RSS: Main: 140709888 15:50:23 INFO - PROCESS | 12528 | 15:53:25 INFO - PROCESS | 12528 | Cycle 1(1): loaded http://localhost:38321/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38321/tests/dromaeo/cssquery-ext.html) 15:53:26 INFO - PROCESS | 12528 | RSS: Main: 240631808 15:53:26 INFO - PROCESS | 12528 | 15:56:28 INFO - PROCESS | 12528 | Cycle 1(1): loaded http://localhost:38321/tests/dromaeo/cssquery-ext.html (next: http://localhost:38321/tests/dromaeo/cssquery-jquery.html) 15:56:29 INFO - PROCESS | 12528 | RSS: Main: 232275968 15:56:29 INFO - PROCESS | 12528 | 15:59:31 INFO - PROCESS | 12528 | Cycle 1(1): loaded http://localhost:38321/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38321/tests/dromaeo/cssquery-mootools.html) 15:59:31 INFO - PROCESS | 12528 | RSS: Main: 212439040 15:59:31 INFO - PROCESS | 12528 | 16:02:33 INFO - PROCESS | 12528 | Cycle 1(1): loaded http://localhost:38321/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38321/tests/dromaeo/cssquery-prototype.html) 16:02:34 INFO - PROCESS | 12528 | RSS: Main: 215359488 16:02:34 INFO - PROCESS | 12528 | 16:05:37 INFO - PROCESS | 12528 | Cycle 1(1): loaded http://localhost:38321/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38321/tests/dromaeo/cssquery-yui.html) 16:05:37 INFO - PROCESS | 12528 | RSS: Main: 175370240 16:05:37 INFO - PROCESS | 12528 | 16:08:40 INFO - PROCESS | 12528 | Cycle 1(1): loaded http://localhost:38321/tests/dromaeo/cssquery-yui.html (next: http://localhost:38321/tests/dromaeo/cssquery-dojo.html) 16:08:40 INFO - PROCESS | 12528 | RSS: Main: 265883648 16:08:40 INFO - PROCESS | 12528 | 16:08:40 INFO - PROCESS | 12528 | __start_tp_report 16:08:40 INFO - PROCESS | 12528 | _x_x_mozilla_page_load 16:08:40 INFO - PROCESS | 12528 | _x_x_mozilla_page_load_details 16:08:40 INFO - PROCESS | 12528 | |i|pagename|runs| 16:08:40 INFO - PROCESS | 12528 | |0;dojo.html;3167.6357218919825;3171.9841400793;3197.4244635965515;3224.532442795793;3237.9514307285394;5581.469760372763;5643.181738647899;5656.57575681824;5660.264165658469;5671.035923892938;5676.205331253628;5756.366799652035;5757.510611598019;5760.395158508359;5784.566157538191;5134.563562097226;5160.6903585784785;5171.793128274883;5213;5245.396779370364;5043.52086551777;5051.494850514956;5264;5267.894642107156;5291.920621190685;5012.8496145115705;5025.3467049283545;5078.59371250301;5089.6691715038405;5138.3577052868395;5151;5185.455527169649;5230.267762513251;5243.947560524384;5276.498732620395;4961.950380496185;5074;5152.536271735525;5192.61055420845;5216.921746173811;5499.587530935196;5501.614886957875;5556.249906262643;5562.054450743383;5586.525145362649;5995.1906492623375;6001.699915004276;6104.633721976696;6107.908381374283;6113.755449782004;5875.529957603424;6095.878082438371;6102.542309326818;6133.539984501135;6135.386461353829;5536.252605898192;5591.916121258185;5629.127485239754;5634.126710359901;5689.77240910359;6252.249730032425;6258.061290806324;6259.874802503924;6276.058591211264;6280.309165991737;5694.686792226467;5979.4917432018765;5997.55018373615;6000.489958353502;6010.0083486224285;5829.591928565044;5987.13186587951;6039.184710064173;6052.394760524;6131.294901086343;6038.909416358758;6041.459427845959;6042.667653279024;6047.637141771508;6100.8779824404155;6003.189569408074;6073.058675905242;6085.4523092921845;6088.695565221721;6088.908666370008;4562.931556026662;4591.380163677927;4611.2852507861335;4632.444106707149;4645.117427688729;4153.709240353146;4158;4161.91676166481;4176.9582304176565;4204.957950420518;5792.652440853562;5794.710264486843;5800.419958004166;5805.709714514342;5812.418758124154;5926.822195334147;5952.494038006731;5993.130996005555;6091.02543593023;6104.877902441926;5719.542436605062;5755.539556835443;5766.336871259775;5791.0734282514595;5809.2738407699035;5166.844994650167;5179.792808287626;5189.844304670866;5191.480851914778;5227.424983251839;6092.695365231721;6134.723937422916;6171.59884607499;6222.004479283383;6291.182146320949;6018.638881667114;6035.245594300713;6067.029275315928;6071.362506936708;6103.938960610337;6254.6165977919745;6289.591176573508;6290.150829637941;6298.0867774171575;6302.432781049728;5803.39064398249;5945.762169513344;5947.434993675594;5949.494292985145;5976.880462390641;5914.142449344907;5981.671008094597;6018.578699490994;6038;6084.787032453843;5938.198343223782;5940.732667030081;5942.64344139353;5944.464998150187;5950.077737950624;5903.675297858659;5906.675132867562;5929.99190137669;5930.258717660293;5934.258217722785;5609.21470994053;5723.742431590672;5729.942700572941;5776.768929242783;5821.970890145522;5977.581569290108;5980.641161530322;5982.670953097621;5997.730102145501;6015.669138197266;5547.084731019337;5595.5523558116065;5840.94159058421;5845.678487683218;5855 16:08:40 INFO - PROCESS | 12528 | |1;ext.html;591.9585629005969;601.0863487499001;632.9556931014828;656.865342604766;672.0322735261227;45677;47017.764911175436;47026.999999999956;47107;51726;48564.75717621407;49215;49244;49246.75376623121;49277.50722492774;8488.78778030548;8680.652773889069;8689.826203475926;8971.10288971101;9073.727788166332;8727.432716873383;10744.409057501873;11041.116710663127;11050.557977680883;11369;11241;11306.152038597096;11308.03881670059;11316.603918862842;11320;11087.55649774008;11146.777064458705;11149.442527873654;11150.665480035612;11167.888321116767;11005.504752286086;11057.281276716987;11075.390853503053;11101.611443599517;11113.611023614134;45118.77440612809;45326.77336613329;45328.3200751989;45347.546524534664;45468.54531454676;3634.8727794527063;3720.795356255405;4236.639885609727;4266.168097221043;4348.782560871944;31754.364912701847;34009.6599034009;34504.82747586271;35124.29751404983;35176.64823351759;4434.73391596502;4479.17135329965;4504.121696269229;4505.7296562206375;4725.952740472586;346023;348036;348058;349201;351413;38701.612983870364;66817;67107.66446167738;67128.66435667888;67157.3284267151;39432.21135577272;41667.583324166975;41989;42056.57943420527;42104.36843447351;17145.742813857803;17296.740548891776;17304.134793260288;17313.480595582154;17317.4804755855;13411.865881341257;13618.18290902549;14493.7825932609;14592.562223133324;14627.853721462649;9360.485173315534;9637.325387222827;9643.08390702882;9732.54011898221;9777.071178238057;3599.6040435552068;3607.4228123500116;3636.1818590816856;3637.5998640149564;3661.9267614647556;1073.7100982734619;1074.1621535202555;1081.9459027048615;1123.7246874515795;1138.681169272605;32452.67547324544;33154.668453315644;33171.83414082914;33313.50029749556;33702.49446258308;1105.988020960828;1156.8206927926185;1165.8134698448207;1173.6948393417772;1212.9992755976355;17488;17519.73720394195;17539.561510962074;17643.647127057644;17703.645927081387;509809;514915;519405;520118;521581;43166.56833431625;43528.347074793906;43566.56433435689;43590.12819743587;43600.78199608982;1325.615571484278;1377.9035467517178;1402.929853507341;1412.8445870954188;1440.373437554688;31985;34185.82907085449;34273.82863085669;34361.14097147491;34415.311693765485;54494.18258726043;55174;55274.44725552693;55276;55296.44703552913;379206;381996;382104;382386;382537;27516.58725119085;28150.155495335173;28198.85900570484;31017;31699.207519811265;41130.588694112674;52564.73717631387;52756;53063.73468132634;53533.73233133809;42327.788361057996;42638;42960;43520;44879.32681009853;41511.37732933948;42595;43388.34917476177;43632.56367436285;44741.55258447374;41760.3735943955;42572.36141457943;43136.78431607947;43767.56232437635;43921;35982.64017359898;37810;38259.80870095632;38665.42001870031;38956.41565376465;27829.860850695615;28408.289792755346;28645.713542864305;28796.71203288024;28840.711592884643 16:08:40 INFO - PROCESS | 12528 | |2;jquery.html;422.06302009538814;430.56837988771633;435.09066051951413;437.85769624871915;446.7141029740968;18778.15498302576;19886.303979360706;20402.59194816103;20627.38117856467;20786.688199677017;20132;20138;20646.48383790406;20647.483812904684;20787.896060519714;5790.276215473066;6083.3612470690605;6089.665068421235;6096;6096.664683442409;5826.329972053205;5924.466797988181;5967.761289548413;5991.880162396749;6087.604305720136;5891.381404952483;5929.911051334234;5930.288365396159;5937.346891841894;5937.7624895004365;5725.227094342252;5869.85325366865;5909.556783241253;5952.494038006775;5968.31364393096;5368.8389348319615;5384;5393.1370980642905;5395;5398.433164517708;23797.524049519085;23825;23861;23981.760182398128;23998.640020399707;2520.1809411941194;2572.15119010726;2600.2719238613217;2645.8941642334285;3167.825769582672;14737.189454579993;14789.926050369786;15172.848271517254;15226.543203703906;15692.13693246871;1931.6233334499777;1993.6511110555596;2016.3850025742142;2018.414659748671;2047.4369548374316;82951;84754;85741;86045.56977215137;86237;10363.533640986174;10532.31539949916;10712.250142489951;11449.255798373079;11451.423429728244;16419.753703694456;16441.506754797374;16452.095134767704;16453.42413015539;16458.09480478561;8730.432521886058;8853.955730221307;8940.597673104727;8998.460092394478;9042.231410330063;8653.956730216309;8700;8771.132021727875;8915.598798054103;8982.550872456351;7006.229314775371;7019.543729657556;7045.859082818315;7046.401055910203;7102.254263302382;2086.1863873089505;2087.7390326209224;2104.5054412213117;2118.2903727251237;2146.6028784674886;951.2104952889085;966.6616684160488;1013.5388398278766;1028.6296933104077;1061.124572227915;19959.30956225286;20283.290084847256;20292.695609565868;20366.796332036785;20505.38483845487;1033.178622994721;1033.9224558158019;1043.89561043895;1086.7989421956963;1112.799696054718;10571.841422378671;11485.942570287096;11577.363245021605;11602.535898564132;11646.53413863453;478149;478153;499157;501431;503273;82734;84656;85083.9033536536;85350;85645;1028.3315844700855;1061.4162210784039;1066.8826429092794;1077.1705786544317;1077.4612693653173;16901.492955211364;17139;17830.37593684215;17835.375761848274;17916.193771280065;44211.33682994694;44602;44657.33014004728;45452.545474546154;46884.29673554967;55870.720646396505;59280.40719592749;60215.39784602273;60855.39144608497;61157.38842611517;8776.868346974928;8813.471191728517;8959.238464730572;8978.55107244622;9171.63313467454;7173.784786456415;10029.796424429116;13456.394462249027;13730.725385492435;14241.287935602972;6346.270178929482;11705.473253703434;12252.938735306267;12488.937555312164;12496.500139994298;11647.534098635959;11740.119491038036;12004.579839705568;12234.755304893673;12381.00951923862;5818.44724751148;6898.8620227596175;11616.244944078946;12123.939380303042;12333.519977602746;8631.180037896389;8976.371653984159;9067.68263110788;9083.091690830865;9127;9514.524273786421;11860.288382697066;12006;12020.579279725518;12441.440135193758 16:08:40 INFO - PROCESS | 12528 | |3;mootools.html;1380.613428240092;1512;1530.2707940027767;1735.5921358480755;1881.4449737327495;7763.611819409028;8739.606717697703;8959.91040089599;8978.147076027775;9313.58088886;9125.31560132991;9172.357934944557;9176.357654964138;9206.217471514912;9219.953900230506;2492.0779311654715;2517.546841568517;2521.2688320387065;2523.2430270918744;2525.0783464035585;2427.611582146857;2512.4472616024445;2516.169664010872;2516.5218608464334;2520.281719709874;2470.7158676752224;2481.0323973650293;2493.551160791057;2494.6008638617823;2497.126005897939;2343.61330380487;2370.7747763962484;2407.422218667516;2427.538767634144;2428.3322086426197;2387.2599494156693;2397.280815755284;2427.3324835670155;2431.367844360479;2431.683881095464;8799.12008799115;9026.45841249527;9097.818043639156;9157.771055723593;9250.907490925072;5589.524890384322;5728.942710572883;5740.196372507852;5742.7415766290615;5744.368119506851;3501.7898926064263;3629.618890016563;3629.909252268688;3664.798436086014;3667.8553234844453;1194.2595590733802;1196.8397043336774;1219.5304807649031;1229.201019337429;1300.5383089003362;12623.116381853273;12667.429965651569;12692.555760548428;12710.745785084246;12721.427535760913;4605.470370907388;4721.504242054535;4862.927056094161;4878.487758785347;4879.609631229493;9997.400155990665;10019.849702254473;10027;10033.899661003443;10037.849432258521;5595.804146854922;5602.243697100921;5602.943970560324;5604.075327570987;5610.214569960209;4293.91412171761;4432.2908334666945;4600.631949444037;5009.5491405773655;5196.428392876781;4052.3313653247474;4053.7365071270274;4175.248455278079;4190.329547272422;4191.350340697197;1223.7736018836545;1253.4296894912793;1259.0808709642013;1263.9304838233802;1264.1277518512197;823.2014945502852;824.9670013199525;841.2302742990096;917.1653795046476;1008.3445760255893;5681.062624666966;5736.110902810071;5783.045797443375;5812.38969908162;5887.882242355129;893.848045832197;915.5651065743718;949.544218774978;961.7307153996892;999.9700308682069;3872.903177420587;3920.1017430986985;3934.252492026506;4054.9797251014147;4090.6318431341324;10348.689539313833;11076.723081923017;11102.555897764161;11137.832932506019;11144.721381965353;10560.52477638508;10848.18638602108;11015.944920275348;11066.446677666085;11081.501332440059;8535.103814099555;8711.998120216129;8760.386772925835;8768.868466973001;8776.385653004229;5674.971625142013;5972.910406343822;5985.940140598538;5990.371011043778;6172.197614310111;9847.113759761656;10379;10424.270301079156;10428.843567346345;10471.94764026175;9153.130452606993;9366.95316523413;10316.27786054969;10701.892981070401;10711.785764284827;7649.235076492307;7801.2198780121535;7865;7996.080450748006;8062;8917.197452229331;8953.104689531256;8975.551222438982;8986.775330616787;8992.100789921216;7806;7929.484583502054;8046.0747014091785;8048.074471435626;8073.273405393543;7704.576248306397;7808.6876524940635;7876.881846772418;7892.4869883457395;7905.486143400661;7246.1666908306215;7319.597422141834;7376.96311518439;7380.1512826023545;7383;5015.1474249378425;5023.095842748195;5058.721770302669;5071.898562028812;5225.973870130625;5197.870053248699;5254.395744489279;5259.342582177228;5266.473352664703;5505.119180931032 16:08:40 INFO - PROCESS | 12528 | |4;prototype.html;336.71042903103336;340.3754111205937;352.78832700379775;358.78293632352444;359.64035964035963;5486.3690675572325;5513.145462453316;5517.36550296716;5519.475649813271;5537.778488860441;5156.793728250866;5233.467409498583;5279.706471914376;5306.151015837467;5477.4796394342575;4142.212979533879;4167.52073511547;4167.8541251056295;4234.97882510587;4281.272183728758;4258.382534532491;4275.636570891463;4280.186764514748;4299.548547402509;4312.417823593822;4123.876283711494;4221.134667393192;4223.429836972;4240.130773191504;4256.382824490447;4174.415581818548;4211.894702632443;4223.282042052859;4233.216854881826;4240.491141063061;3786.2048969716116;3790.1851102012924;3792.5069740933777;3796.620337966209;3807.2956503047026;5053.523773351031;5280.551153151987;5281.841544753664;5303.469653034705;5311.7344132793205;4854.902901941941;4861.611071114337;4864.7324397158145;4864.854054378375;4885.60915126789;5664.111303235339;5668.574856885709;5675.63108397957;5683.403242659544;5686.715664216814;4029.53660329063;4099.139180772041;4128.298189307825;4138.772367519785;4141.627253547165;5828.504577110951;5847.736851841635;5857.297124345106;5887.911681324784;5892.882142357172;4201.138766552849;4205.306124489425;4207.221663992172;4215.346621273708;4258.53156152823;4100.6924480664065;4211.915761684749;4284.3145096784365;4315.935260971088;4317.287647538121;4823.589994850407;4835.008823191238;4848.781804818721;4857.368542089505;4867.318575399447;5728.541716662657;5729.28383952006;5743.295574354518;5747.195392645033;5751.798687046017;1425.9928700356431;1441.2145380767297;1457.5554455891056;1458.50410860308;1475.3139789997704;976.1556253840519;987.2891518106951;994.2443742755557;998.55065220651;1011.4841430870162;5267.578593712494;5309.283246761638;5329.8934021319355;5330.760115794721;5331.466853314715;5551.001639409809;5575.386707462176;5637.49262566371;5662.009148399014;5677.716114194273;5148.722036769528;5229.973850130725;5265.578293860636;5269.525742683177;5328.001999250281;2980.5231163014246;2992.730654241129;2995.550667399864;2996.700329966986;3003.4293484237924;5758.510526605201;5788.842231553622;5805.94194058054;5824.912626310609;5851.912221316684;5455.509004189642;5638.323401191883;5659.632123912015;5682.176084467812;5710.829279997591;5776.855578610484;5791.305043394819;5791.82624521265;5808.738606762706;5843.970780146072;5349.812756553502;5617.601351182476;5623.297087864017;5625.409332020243;5653.773849046157;5550.361708403585;5550.584600926738;5567.415421380697;5571.66570005801;5578.916316255179;5809.419058094157;5823.18475413451;5842.444967728059;5854.795082172103;5867.9413205869105;3935.724499285137;4078.734882232764;4105.2405305018665;4106.445629840053;4132.5454200038575;5607.523360514238;5704.914426283692;5730.369659337553;5759.51044161251;5829.912551311649;5678.829635110953;5680.68756218412;5728.856778580569;5730.799422020209;5738.8278351649515;5508.669479831223;5636.351819540805;5683.488486036276;5704.743286552032;5705.6021274787945;5625.803096891753;5634.32388113429;5670.958454956295;5672.858178545569;5676.4323567642905;5665.263515743092;5709.600327977002;5728.828135155952;5754.0297194935365;5764.769409223584;5404.2163886235485;5536.584756143225;5565.777368905198;5566.409665765639;5575.4424557543925 16:08:40 INFO - PROCESS | 12528 | |5;yui.html;725.8403151306711;761.7562380038387;804.5574933786417;816.1960468938099;869.7173418638941;14897.77653335201;15433;15737.685246295066;15838.28727707253;16256.51230463088;13667.111637743565;13946.860531394708;13985.720285594281;13995.580132596013;14032.087914285565;733.3546479098386;847.5296210603112;859.1365677494109;859.166608389864;859.3726579596898;747.4655621230819;840.9243168114868;854.7734850264685;862.0818827948215;862.7196161247588;895.879056327394;904.1410659873147;907.4373888189332;907.5008745190152;907.9273658107336;905.5924833824805;905.8777065096259;910.4582773249906;910.7677542226756;911.5715613661569;672.5729161982127;674.6222115615271;674.9831254218684;675.5541342713834;675.7769935921134;14649.12105273687;14870.479533216285;14888.70222595542;14902.776458353133;15502.147381894105;14787;15063.623409414742;15514.61213469661;15540.456084037005;15615.609609759733;11622.186446948717;11701.824472632918;11724.88275117255;11768;11792.174547781658;3737.3085979093953;3796.1648437343742;3803.2013277211818;3857.112864041258;3890.4164375343644;66368.3363166367;67058;67398.66300668515;67628.6618566904;68005;10930.945345273223;11082.390468524309;11108.722281943015;11171.532339690735;11175.44122793857;19690.40928772139;19751.111199995747;19781.30765423232;19932.70100948487;19956.10197541114;7794.883076753853;7866.09539902907;8070.47541909774;8086.070101938352;8134.511929284262;4567.063751930847;4575.290829921368;4619.284010978236;4629.421322334708;4761.595264402496;3310.66893310667;3421.196018935548;3424.4863270509622;3426.503157042265;3426.674465925733;612.8958077126899;614.58208418276;617.3147805935408;627.6924307089585;629.2071989293523;550.5870448356427;597.3817099302202;654.5287393077073;665.2682049745241;668.9163854518185;8586.656533738706;8905.821883562292;9076.727698169065;9114.453132812052;9194.540272986324;603.2579926690196;624.2508989212963;637.8692368064536;649.5226008883467;653.4413076819251;4072.165206132736;4272.722273052242;4278.229918614679;4379.693421460467;4466.731996080245;82796.58601706952;83806.58096709478;85767.5711621438;88292;88974.55512722525;74263;76328.23671763322;78636.21363786403;78984.21015789884;79334.20665793384;59733.22134229251;70825;71264.64367678128;71622.28377716156;72032.63983680152;8512.233898949124;9028.503432311287;9145.542722863964;9192.908070919206;9269.814603708022;32889.34221315608;33810;43020.78489607532;44525;46957.765211173726;60284;61873;62208.57852818139;62433.68783156055;62950;12549.874501255235;12626.116171867881;12711;12762.42569084375;12820.743585128432;13766.862331376558;13965.58103256904;14059.367328470038;14087.295635217994;14151.504697335544;12748.808767868304;12826.294553799631;12848.871511284768;13032.674183145118;13156.868431315947;12917.56807161507;12974.351282435651;13040.673983150496;13115.081944264191;13264.475121660618;11897.881021189678;11901.345426001306;11903;12105.455254513392;12232.633021009384;10157.593696252066;10334.018268264503;10613.681589552325;10695.893041069801;11094.167937404565;10700.304480209074;11012.449377530931;11100.888991109985;11156.274842135235;11211.943940280247 16:08:40 INFO - PROCESS | 12528 | __end_tp_report 16:08:40 INFO - PROCESS | 12528 | __start_cc_report 16:08:40 INFO - PROCESS | 12528 | _x_x_mozilla_cycle_collect,973 16:08:40 INFO - PROCESS | 12528 | __end_cc_report 16:08:40 INFO - PROCESS | 12528 | __startTimestamp1488413320417__endTimestamp 16:08:40 INFO - PROCESS | 12528 | 16:08:40 INFO - PROCESS | 12528 | ------- Summary: start ------- 16:08:40 INFO - PROCESS | 12528 | Number of tests: 6 16:08:40 INFO - PROCESS | 12528 | 16:08:40 INFO - PROCESS | 12528 | [#0] dojo.html Cycles:165 Average:5615.93 Median:5812.42 stddev:644.37 (11.1%) stddev-sans-first:617.06 16:08:40 INFO - PROCESS | 12528 | Values: 3167.6 3172.0 3197.4 3224.5 3238.0 5581.5 5643.2 5656.6 5660.3 5671.0 5676.2 5756.4 5757.5 5760.4 5784.6 5134.6 5160.7 5171.8 5213.0 5245.4 5043.5 5051.5 5264.0 5267.9 5291.9 5012.8 5025.3 5078.6 5089.7 5138.4 5151.0 5185.5 5230.3 5243.9 5276.5 4962.0 5074.0 5152.5 5192.6 5216.9 5499.6 5501.6 5556.2 5562.1 5586.5 5995.2 6001.7 6104.6 6107.9 6113.8 5875.5 6095.9 6102.5 6133.5 6135.4 5536.3 5591.9 5629.1 5634.1 5689.8 6252.2 6258.1 6259.9 6276.1 6280.3 5694.7 5979.5 5997.6 6000.5 6010.0 5829.6 5987.1 6039.2 6052.4 6131.3 6038.9 6041.5 6042.7 6047.6 6100.9 6003.2 6073.1 6085.5 6088.7 6088.9 4562.9 4591.4 4611.3 4632.4 4645.1 4153.7 4158.0 4161.9 4177.0 4205.0 5792.7 5794.7 5800.4 5805.7 5812.4 5926.8 5952.5 5993.1 6091.0 6104.9 5719.5 5755.5 5766.3 5791.1 5809.3 5166.8 5179.8 5189.8 5191.5 5227.4 6092.7 6134.7 6171.6 6222.0 6291.2 6018.6 6035.2 6067.0 6071.4 6103.9 6254.6 6289.6 6290.2 6298.1 6302.4 5803.4 5945.8 5947.4 5949.5 5976.9 5914.1 5981.7 6018.6 6038.0 6084.8 5938.2 5940.7 5942.6 5944.5 5950.1 5903.7 5906.7 5930.0 5930.3 5934.3 5609.2 5723.7 5729.9 5776.8 5822.0 5977.6 5980.6 5982.7 5997.7 6015.7 5547.1 5595.6 5840.9 5845.7 5855.0 16:08:40 INFO - PROCESS | 12528 | 16:08:40 INFO - PROCESS | 12528 | [#1] ext.html Cycles:180 Average:58218.60 Median:382245.00 stddev:111630.01 (29.2%) stddev-sans-first:111859.32 16:08:40 INFO - PROCESS | 12528 | Values: 592.0 601.1 633.0 656.9 672.0 45677.0 47017.8 47027.0 47107.0 51726.0 48564.8 49215.0 49244.0 49246.8 49277.5 8488.8 8680.7 8689.8 8971.1 9073.7 8727.4 10744.4 11041.1 11050.6 11369.0 11241.0 11306.2 11308.0 11316.6 11320.0 11087.6 11146.8 11149.4 11150.7 11167.9 11005.5 11057.3 11075.4 11101.6 11113.6 45118.8 45326.8 45328.3 45347.5 45468.5 3634.9 3720.8 4236.6 4266.2 4348.8 31754.4 34009.7 34504.8 35124.3 35176.6 4434.7 4479.2 4504.1 4505.7 4726.0 346023.0 348036.0 348058.0 349201.0 351413.0 38701.6 66817.0 67107.7 67128.7 67157.3 39432.2 41667.6 41989.0 42056.6 42104.4 17145.7 17296.7 17304.1 17313.5 17317.5 13411.9 13618.2 14493.8 14592.6 14627.9 9360.5 9637.3 9643.1 9732.5 9777.1 3599.6 3607.4 3636.2 3637.6 3661.9 1073.7 1074.2 1081.9 1123.7 1138.7 32452.7 33154.7 33171.8 33313.5 33702.5 1106.0 1156.8 1165.8 1173.7 1213.0 17488.0 17519.7 17539.6 17643.6 17703.6 509809.0 514915.0 519405.0 520118.0 521581.0 43166.6 43528.3 43566.6 43590.1 43600.8 1325.6 1377.9 1402.9 1412.8 1440.4 31985.0 34185.8 34273.8 34361.1 34415.3 54494.2 55174.0 55274.4 55276.0 55296.4 379206.0 381996.0 382104.0 382386.0 382537.0 27516.6 28150.2 28198.9 31017.0 31699.2 41130.6 52564.7 52756.0 53063.7 53533.7 42327.8 42638.0 42960.0 43520.0 44879.3 41511.4 42595.0 43388.3 43632.6 44741.6 41760.4 42572.4 43136.8 43767.6 43921.0 35982.6 37810.0 38259.8 38665.4 38956.4 27829.9 28408.3 28645.7 28796.7 28840.7 16:08:40 INFO - PROCESS | 12528 | 16:08:40 INFO - PROCESS | 12528 | [#2] jquery.html Cycles:180 Average:29471.59 Median:2623.08 stddev:81026.49 (3089.0%) stddev-sans-first:81224.43 16:08:40 INFO - PROCESS | 12528 | Values: 422.1 430.6 435.1 437.9 446.7 18778.2 19886.3 20402.6 20627.4 20786.7 20132.0 20138.0 20646.5 20647.5 20787.9 5790.3 6083.4 6089.7 6096.0 6096.7 5826.3 5924.5 5967.8 5991.9 6087.6 5891.4 5929.9 5930.3 5937.3 5937.8 5725.2 5869.9 5909.6 5952.5 5968.3 5368.8 5384.0 5393.1 5395.0 5398.4 23797.5 23825.0 23861.0 23981.8 23998.6 2520.2 2572.2 2600.3 2645.9 3167.8 14737.2 14789.9 15172.8 15226.5 15692.1 1931.6 1993.7 2016.4 2018.4 2047.4 82951.0 84754.0 85741.0 86045.6 86237.0 10363.5 10532.3 10712.3 11449.3 11451.4 16419.8 16441.5 16452.1 16453.4 16458.1 8730.4 8854.0 8940.6 8998.5 9042.2 8654.0 8700.0 8771.1 8915.6 8982.6 7006.2 7019.5 7045.9 7046.4 7102.3 2086.2 2087.7 2104.5 2118.3 2146.6 951.2 966.7 1013.5 1028.6 1061.1 19959.3 20283.3 20292.7 20366.8 20505.4 1033.2 1033.9 1043.9 1086.8 1112.8 10571.8 11485.9 11577.4 11602.5 11646.5 478149.0 478153.0 499157.0 501431.0 503273.0 82734.0 84656.0 85083.9 85350.0 85645.0 1028.3 1061.4 1066.9 1077.2 1077.5 16901.5 17139.0 17830.4 17835.4 17916.2 44211.3 44602.0 44657.3 45452.5 46884.3 55870.7 59280.4 60215.4 60855.4 61157.4 8776.9 8813.5 8959.2 8978.6 9171.6 7173.8 10029.8 13456.4 13730.7 14241.3 6346.3 11705.5 12252.9 12488.9 12496.5 11647.5 11740.1 12004.6 12234.8 12381.0 5818.4 6898.9 11616.2 12123.9 12333.5 8631.2 8976.4 9067.7 9083.1 9127.0 9514.5 11860.3 12006.0 12020.6 12441.4 16:08:40 INFO - PROCESS | 12528 | 16:08:40 INFO - PROCESS | 12528 | [#3] mootools.html Cycles:180 Average:5931.33 Median:5012.35 stddev:3336.13 (66.6%) stddev-sans-first:3327.96 16:08:40 INFO - PROCESS | 12528 | Values: 1380.6 1512.0 1530.3 1735.6 1881.4 7763.6 8739.6 8959.9 8978.1 9313.6 9125.3 9172.4 9176.4 9206.2 9220.0 2492.1 2517.5 2521.3 2523.2 2525.1 2427.6 2512.4 2516.2 2516.5 2520.3 2470.7 2481.0 2493.6 2494.6 2497.1 2343.6 2370.8 2407.4 2427.5 2428.3 2387.3 2397.3 2427.3 2431.4 2431.7 8799.1 9026.5 9097.8 9157.8 9250.9 5589.5 5728.9 5740.2 5742.7 5744.4 3501.8 3629.6 3629.9 3664.8 3667.9 1194.3 1196.8 1219.5 1229.2 1300.5 12623.1 12667.4 12692.6 12710.7 12721.4 4605.5 4721.5 4862.9 4878.5 4879.6 9997.4 10019.8 10027.0 10033.9 10037.8 5595.8 5602.2 5602.9 5604.1 5610.2 4293.9 4432.3 4600.6 5009.5 5196.4 4052.3 4053.7 4175.2 4190.3 4191.4 1223.8 1253.4 1259.1 1263.9 1264.1 823.2 825.0 841.2 917.2 1008.3 5681.1 5736.1 5783.0 5812.4 5887.9 893.8 915.6 949.5 961.7 1000.0 3872.9 3920.1 3934.3 4055.0 4090.6 10348.7 11076.7 11102.6 11137.8 11144.7 10560.5 10848.2 11015.9 11066.4 11081.5 8535.1 8712.0 8760.4 8768.9 8776.4 5675.0 5972.9 5985.9 5990.4 6172.2 9847.1 10379.0 10424.3 10428.8 10471.9 9153.1 9367.0 10316.3 10701.9 10711.8 7649.2 7801.2 7865.0 7996.1 8062.0 8917.2 8953.1 8975.6 8986.8 8992.1 7806.0 7929.5 8046.1 8048.1 8073.3 7704.6 7808.7 7876.9 7892.5 7905.5 7246.2 7319.6 7377.0 7380.2 7383.0 5015.1 5023.1 5058.7 5071.9 5226.0 5197.9 5254.4 5259.3 5266.5 5505.1 16:08:40 INFO - PROCESS | 12528 | 16:08:40 INFO - PROCESS | 12528 | [#4] prototype.html Cycles:180 Average:4738.25 Median:5377.01 stddev:1368.75 (25.5%) stddev-sans-first:1332.12 16:08:40 INFO - PROCESS | 12528 | Values: 336.7 340.4 352.8 358.8 359.6 5486.4 5513.1 5517.4 5519.5 5537.8 5156.8 5233.5 5279.7 5306.2 5477.5 4142.2 4167.5 4167.9 4235.0 4281.3 4258.4 4275.6 4280.2 4299.5 4312.4 4123.9 4221.1 4223.4 4240.1 4256.4 4174.4 4211.9 4223.3 4233.2 4240.5 3786.2 3790.2 3792.5 3796.6 3807.3 5053.5 5280.6 5281.8 5303.5 5311.7 4854.9 4861.6 4864.7 4864.9 4885.6 5664.1 5668.6 5675.6 5683.4 5686.7 4029.5 4099.1 4128.3 4138.8 4141.6 5828.5 5847.7 5857.3 5887.9 5892.9 4201.1 4205.3 4207.2 4215.3 4258.5 4100.7 4211.9 4284.3 4315.9 4317.3 4823.6 4835.0 4848.8 4857.4 4867.3 5728.5 5729.3 5743.3 5747.2 5751.8 1426.0 1441.2 1457.6 1458.5 1475.3 976.2 987.3 994.2 998.6 1011.5 5267.6 5309.3 5329.9 5330.8 5331.5 5551.0 5575.4 5637.5 5662.0 5677.7 5148.7 5230.0 5265.6 5269.5 5328.0 2980.5 2992.7 2995.6 2996.7 3003.4 5758.5 5788.8 5805.9 5824.9 5851.9 5455.5 5638.3 5659.6 5682.2 5710.8 5776.9 5791.3 5791.8 5808.7 5844.0 5349.8 5617.6 5623.3 5625.4 5653.8 5550.4 5550.6 5567.4 5571.7 5578.9 5809.4 5823.2 5842.4 5854.8 5867.9 3935.7 4078.7 4105.2 4106.4 4132.5 5607.5 5704.9 5730.4 5759.5 5829.9 5678.8 5680.7 5728.9 5730.8 5738.8 5508.7 5636.4 5683.5 5704.7 5705.6 5625.8 5634.3 5671.0 5672.9 5676.4 5665.3 5709.6 5728.8 5754.0 5764.8 5404.2 5536.6 5565.8 5566.4 5575.4 16:08:40 INFO - PROCESS | 12528 | 16:08:40 INFO - PROCESS | 12528 | [#5] yui.html Cycles:180 Average:17770.99 Median:4597.29 stddev:23498.73 (511.1%) stddev-sans-first:23529.79 16:08:40 INFO - PROCESS | 12528 | Values: 725.8 761.8 804.6 816.2 869.7 14897.8 15433.0 15737.7 15838.3 16256.5 13667.1 13946.9 13985.7 13995.6 14032.1 733.4 847.5 859.1 859.2 859.4 747.5 840.9 854.8 862.1 862.7 895.9 904.1 907.4 907.5 907.9 905.6 905.9 910.5 910.8 911.6 672.6 674.6 675.0 675.6 675.8 14649.1 14870.5 14888.7 14902.8 15502.1 14787.0 15063.6 15514.6 15540.5 15615.6 11622.2 11701.8 11724.9 11768.0 11792.2 3737.3 3796.2 3803.2 3857.1 3890.4 66368.3 67058.0 67398.7 67628.7 68005.0 10930.9 11082.4 11108.7 11171.5 11175.4 19690.4 19751.1 19781.3 19932.7 19956.1 7794.9 7866.1 8070.5 8086.1 8134.5 4567.1 4575.3 4619.3 4629.4 4761.6 3310.7 3421.2 3424.5 3426.5 3426.7 612.9 614.6 617.3 627.7 629.2 550.6 597.4 654.5 665.3 668.9 8586.7 8905.8 9076.7 9114.5 9194.5 603.3 624.3 637.9 649.5 653.4 4072.2 4272.7 4278.2 4379.7 4466.7 82796.6 83806.6 85767.6 88292.0 88974.6 74263.0 76328.2 78636.2 78984.2 79334.2 59733.2 70825.0 71264.6 71622.3 72032.6 8512.2 9028.5 9145.5 9192.9 9269.8 32889.3 33810.0 43020.8 44525.0 46957.8 60284.0 61873.0 62208.6 62433.7 62950.0 12549.9 12626.1 12711.0 12762.4 12820.7 13766.9 13965.6 14059.4 14087.3 14151.5 12748.8 12826.3 12848.9 13032.7 13156.9 12917.6 12974.4 13040.7 13115.1 13264.5 11897.9 11901.3 11903.0 12105.5 12232.6 10157.6 10334.0 10613.7 10695.9 11094.2 10700.3 11012.4 11100.9 11156.3 11211.9 16:08:40 INFO - PROCESS | 12528 | -------- Summary: end -------- 16:08:40 INFO - PROCESS | 12528 | 16:08:41 INFO - TEST-INFO | 12528: exit 0 16:08:41 INFO - TEST-OK | dromaeo_css | took 1116127ms 16:08:41 INFO - TEST-START | kraken 16:08:41 INFO - operating with platform_type : linux_ 16:08:41 INFO - Initialising browser for kraken test... 16:08:41 INFO - TEST-INFO | started process 12827 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRhN_vb/profile http://localhost:38321/getInfo.html) 16:08:45 INFO - PROCESS | 12827 | __metrics Screen width/height:1600/1200 16:08:45 INFO - PROCESS | 12827 | colorDepth:24 16:08:45 INFO - PROCESS | 12827 | Browser inner width/height: 1024/697 16:08:45 INFO - PROCESS | 12827 | __metrics 16:08:46 INFO - PROCESS | 12827 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 16:08:46 INFO - PROCESS | 12827 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:08:46 INFO - PROCESS | 12827 | console.error: PushService: 16:08:46 INFO - PROCESS | 12827 | stateChangeProcessEnqueue: Error transitioning state 16:08:46 INFO - PROCESS | 12827 | UnknownError 16:08:47 INFO - TEST-INFO | 12827: exit 0 16:08:47 INFO - Browser initialized. 16:08:47 INFO - Running cycle 1/1 for kraken test... 16:08:47 INFO - TEST-INFO | started process 12918 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpRhN_vb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:08:59 INFO - PROCESS | 12918 | RSS: Main: 141082624 16:08:59 INFO - PROCESS | 12918 | 16:09:01 INFO - PROCESS | 12918 | Cycle 1(1): loaded http://localhost:38321/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38321/tests/kraken/driver.html?testName=audio-beat-detection) 16:09:02 INFO - PROCESS | 12918 | RSS: Main: 183164928 16:09:02 INFO - PROCESS | 12918 | 16:09:05 INFO - PROCESS | 12918 | Cycle 1(1): loaded http://localhost:38321/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38321/tests/kraken/driver.html?testName=audio-dft) 16:09:05 INFO - PROCESS | 12918 | RSS: Main: 172896256 16:09:05 INFO - PROCESS | 12918 | 16:09:08 INFO - PROCESS | 12918 | Cycle 1(1): loaded http://localhost:38321/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38321/tests/kraken/driver.html?testName=audio-fft) 16:09:09 INFO - PROCESS | 12918 | RSS: Main: 264114176 16:09:09 INFO - PROCESS | 12918 | 16:09:11 INFO - PROCESS | 12918 | Cycle 1(1): loaded http://localhost:38321/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38321/tests/kraken/driver.html?testName=audio-oscillator) 16:09:11 INFO - PROCESS | 12918 | RSS: Main: 170954752 16:09:11 INFO - PROCESS | 12918 | 16:09:13 INFO - PROCESS | 12918 | Cycle 1(1): loaded http://localhost:38321/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38321/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:09:14 INFO - PROCESS | 12918 | RSS: Main: 172990464 16:09:14 INFO - PROCESS | 12918 | 16:09:17 INFO - PROCESS | 12918 | Cycle 1(1): loaded http://localhost:38321/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38321/tests/kraken/driver.html?testName=imaging-darkroom) 16:09:17 INFO - PROCESS | 12918 | RSS: Main: 212570112 16:09:17 INFO - PROCESS | 12918 | 16:09:21 INFO - PROCESS | 12918 | Cycle 1(1): loaded http://localhost:38321/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38321/tests/kraken/driver.html?testName=imaging-desaturate) 16:09:21 INFO - PROCESS | 12918 | RSS: Main: 211058688 16:09:21 INFO - PROCESS | 12918 | 16:09:24 INFO - PROCESS | 12918 | Cycle 1(1): loaded http://localhost:38321/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38321/tests/kraken/driver.html?testName=json-parse-financial) 16:09:25 INFO - PROCESS | 12918 | RSS: Main: 209866752 16:09:25 INFO - PROCESS | 12918 | 16:09:26 INFO - PROCESS | 12918 | Cycle 1(1): loaded http://localhost:38321/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38321/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:09:27 INFO - PROCESS | 12918 | RSS: Main: 172044288 16:09:27 INFO - PROCESS | 12918 | 16:09:28 INFO - PROCESS | 12918 | Cycle 1(1): loaded http://localhost:38321/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38321/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:09:29 INFO - PROCESS | 12918 | RSS: Main: 178307072 16:09:29 INFO - PROCESS | 12918 | 16:09:31 INFO - PROCESS | 12918 | Cycle 1(1): loaded http://localhost:38321/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38321/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:09:31 INFO - PROCESS | 12918 | RSS: Main: 188133376 16:09:31 INFO - PROCESS | 12918 | 16:09:34 INFO - PROCESS | 12918 | Cycle 1(1): loaded http://localhost:38321/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38321/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:09:35 INFO - PROCESS | 12918 | RSS: Main: 197120000 16:09:35 INFO - PROCESS | 12918 | 16:09:37 INFO - PROCESS | 12918 | Cycle 1(1): loaded http://localhost:38321/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38321/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:09:38 INFO - PROCESS | 12918 | RSS: Main: 192831488 16:09:38 INFO - PROCESS | 12918 | 16:09:40 INFO - PROCESS | 12918 | Cycle 1(1): loaded http://localhost:38321/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38321/tests/kraken/driver.html?testName=ai-astar) 16:09:40 INFO - PROCESS | 12918 | RSS: Main: 244523008 16:09:40 INFO - PROCESS | 12918 | 16:09:40 INFO - PROCESS | 12918 | __start_tp_report 16:09:40 INFO - PROCESS | 12918 | _x_x_mozilla_page_load 16:09:40 INFO - PROCESS | 12918 | _x_x_mozilla_page_load_details 16:09:40 INFO - PROCESS | 12918 | |i|pagename|runs| 16:09:40 INFO - PROCESS | 12918 | |0;ai-astar;103;112;112;111;112;114;111;110;112;111 16:09:40 INFO - PROCESS | 12918 | |1;audio-beat-detection;159;118;119;167;123;118;121;117;150;118 16:09:40 INFO - PROCESS | 12918 | |2;audio-dft;161;162;159;160;159;159;159;158;163;158 16:09:40 INFO - PROCESS | 12918 | |3;audio-fft;75;74;74;102;77;75;76;75;100;74 16:09:40 INFO - PROCESS | 12918 | |4;audio-oscillator;81;82;121;82;81;82;103;81;80;118 16:09:40 INFO - PROCESS | 12918 | |5;imaging-gaussian-blur;116;117;117;117;117;116;117;117;117;118 16:09:40 INFO - PROCESS | 12918 | |6;imaging-darkroom;146;147;146;146;146;147;146;146;145;145 16:09:40 INFO - PROCESS | 12918 | |7;imaging-desaturate;85;84;85;84;84;84;85;84;84;85 16:09:40 INFO - PROCESS | 12918 | |8;json-parse-financial;50;51;51;52;50;50;50;50;50;49 16:09:40 INFO - PROCESS | 12918 | |9;json-stringify-tinderbox;58;59;58;59;59;59;59;58;59;58 16:09:40 INFO - PROCESS | 12918 | |10;stanford-crypto-aes;74;73;77;79;74;73;74;74;73;75 16:09:40 INFO - PROCESS | 12918 | |11;stanford-crypto-ccm;126;127;121;122;120;127;131;116;159;124 16:09:40 INFO - PROCESS | 12918 | |12;stanford-crypto-pbkdf2;153;154;152;157;153;159;158;157;150;156 16:09:40 INFO - PROCESS | 12918 | |13;stanford-crypto-sha256-iterative;63;62;63;61;63;67;63;63;61;61 16:09:40 INFO - PROCESS | 12918 | __end_tp_report 16:09:40 INFO - PROCESS | 12918 | __start_cc_report 16:09:40 INFO - PROCESS | 12918 | _x_x_mozilla_cycle_collect,1577 16:09:40 INFO - PROCESS | 12918 | __end_cc_report 16:09:40 INFO - PROCESS | 12918 | __startTimestamp1488413380310__endTimestamp 16:09:40 INFO - PROCESS | 12918 | 16:09:40 INFO - PROCESS | 12918 | ------- Summary: start ------- 16:09:40 INFO - PROCESS | 12918 | Number of tests: 14 16:09:40 INFO - PROCESS | 12918 | 16:09:40 INFO - PROCESS | 12918 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:2.94 (2.6%) stddev-sans-first:1.12 16:09:40 INFO - PROCESS | 12918 | Values: 103.0 112.0 112.0 111.0 112.0 114.0 111.0 110.0 112.0 111.0 16:09:40 INFO - PROCESS | 12918 | 16:09:40 INFO - PROCESS | 12918 | [#1] audio-beat-detection Cycles:10 Average:131.00 Median:122.00 stddev:19.58 (16.1%) stddev-sans-first:17.96 16:09:40 INFO - PROCESS | 12918 | Values: 159.0 118.0 119.0 167.0 123.0 118.0 121.0 117.0 150.0 118.0 16:09:40 INFO - PROCESS | 12918 | 16:09:40 INFO - PROCESS | 12918 | [#2] audio-dft Cycles:10 Average:159.80 Median:159.50 stddev:1.69 (1.1%) stddev-sans-first:1.73 16:09:40 INFO - PROCESS | 12918 | Values: 161.0 162.0 159.0 160.0 159.0 159.0 159.0 158.0 163.0 158.0 16:09:40 INFO - PROCESS | 12918 | 16:09:40 INFO - PROCESS | 12918 | [#3] audio-fft Cycles:10 Average:80.20 Median:75.00 stddev:11.01 (14.7%) stddev-sans-first:11.52 16:09:40 INFO - PROCESS | 12918 | Values: 75.0 74.0 74.0 102.0 77.0 75.0 76.0 75.0 100.0 74.0 16:09:40 INFO - PROCESS | 12918 | 16:09:40 INFO - PROCESS | 12918 | [#4] audio-oscillator Cycles:10 Average:91.10 Median:81.00 stddev:16.45 (20.3%) stddev-sans-first:17.04 16:09:40 INFO - PROCESS | 12918 | Values: 81.0 82.0 121.0 82.0 81.0 82.0 103.0 81.0 80.0 118.0 16:09:40 INFO - PROCESS | 12918 | 16:09:40 INFO - PROCESS | 12918 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 16:09:40 INFO - PROCESS | 12918 | Values: 116.0 117.0 117.0 117.0 117.0 116.0 117.0 117.0 117.0 118.0 16:09:40 INFO - PROCESS | 12918 | 16:09:40 INFO - PROCESS | 12918 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 16:09:40 INFO - PROCESS | 12918 | Values: 146.0 147.0 146.0 146.0 146.0 147.0 146.0 146.0 145.0 145.0 16:09:40 INFO - PROCESS | 12918 | 16:09:40 INFO - PROCESS | 12918 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 16:09:40 INFO - PROCESS | 12918 | Values: 85.0 84.0 85.0 84.0 84.0 84.0 85.0 84.0 84.0 85.0 16:09:40 INFO - PROCESS | 12918 | 16:09:40 INFO - PROCESS | 12918 | [#8] json-parse-financial Cycles:10 Average:50.30 Median:50.00 stddev:0.82 (1.6%) stddev-sans-first:0.87 16:09:40 INFO - PROCESS | 12918 | Values: 50.0 51.0 51.0 52.0 50.0 50.0 50.0 50.0 50.0 49.0 16:09:40 INFO - PROCESS | 12918 | 16:09:40 INFO - PROCESS | 12918 | [#9] json-stringify-tinderbox Cycles:10 Average:58.60 Median:59.00 stddev:0.52 (0.9%) stddev-sans-first:0.50 16:09:40 INFO - PROCESS | 12918 | Values: 58.0 59.0 58.0 59.0 59.0 59.0 59.0 58.0 59.0 58.0 16:09:40 INFO - PROCESS | 12918 | 16:09:40 INFO - PROCESS | 12918 | [#10] stanford-crypto-aes Cycles:10 Average:74.60 Median:74.00 stddev:1.96 (2.6%) stddev-sans-first:2.06 16:09:40 INFO - PROCESS | 12918 | Values: 74.0 73.0 77.0 79.0 74.0 73.0 74.0 74.0 73.0 75.0 16:09:40 INFO - PROCESS | 12918 | 16:09:40 INFO - PROCESS | 12918 | [#11] stanford-crypto-ccm Cycles:10 Average:127.30 Median:126.50 stddev:11.93 (9.4%) stddev-sans-first:12.64 16:09:40 INFO - PROCESS | 12918 | Values: 126.0 127.0 121.0 122.0 120.0 127.0 131.0 116.0 159.0 124.0 16:09:40 INFO - PROCESS | 12918 | 16:09:40 INFO - PROCESS | 12918 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.90 Median:156.50 stddev:2.92 (1.9%) stddev-sans-first:3.02 16:09:40 INFO - PROCESS | 12918 | Values: 153.0 154.0 152.0 157.0 153.0 159.0 158.0 157.0 150.0 156.0 16:09:40 INFO - PROCESS | 12918 | 16:09:40 INFO - PROCESS | 12918 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:1.77 (2.8%) stddev-sans-first:1.87 16:09:40 INFO - PROCESS | 12918 | Values: 63.0 62.0 63.0 61.0 63.0 67.0 63.0 63.0 61.0 61.0 16:09:40 INFO - PROCESS | 12918 | -------- Summary: end -------- 16:09:40 INFO - PROCESS | 12918 | 16:09:41 INFO - TEST-INFO | 12918: exit 0 16:09:41 INFO - TEST-OK | kraken | took 60155ms 16:09:41 INFO - SUITE-END | took 1176s 16:09:41 INFO - Completed test suite (00:19:36) 16:09:41 INFO - javascript benchmark 16:09:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3167.6357218919825, 3171.9841400793, 3197.4244635965515, 3224.532442795793, 3237.9514307285394, 5581.469760372763, 5643.181738647899, 5656.57575681824, 5660.264165658469, 5671.035923892938, 5676.205331253628, 5756.366799652035, 5757.510611598019, 5760.395158508359, 5784.566157538191, 5134.563562097226, 5160.6903585784785, 5171.793128274883, 5213.0, 5245.396779370364, 5043.52086551777, 5051.494850514956, 5264.0, 5267.894642107156, 5291.920621190685, 5012.8496145115705, 5025.3467049283545, 5078.59371250301, 5089.6691715038405, 5138.3577052868395, 5151.0, 5185.455527169649, 5230.267762513251, 5243.947560524384, 5276.498732620395, 4961.950380496185, 5074.0, 5152.536271735525, 5192.61055420845, 5216.921746173811, 5499.587530935196, 5501.614886957875, 5556.249906262643, 5562.054450743383, 5586.525145362649, 5995.1906492623375, 6001.699915004276, 6104.633721976696, 6107.908381374283, 6113.755449782004, 5875.529957603424, 6095.878082438371, 6102.542309326818, 6133.539984501135, 6135.386461353829, 5536.252605898192, 5591.916121258185, 5629.127485239754, 5634.126710359901, 5689.77240910359, 6252.249730032425, 6258.061290806324, 6259.874802503924, 6276.058591211264, 6280.309165991737, 5694.686792226467, 5979.4917432018765, 5997.55018373615, 6000.489958353502, 6010.0083486224285, 5829.591928565044, 5987.13186587951, 6039.184710064173, 6052.394760524, 6131.294901086343, 6038.909416358758, 6041.459427845959, 6042.667653279024, 6047.637141771508, 6100.8779824404155, 6003.189569408074, 6073.058675905242, 6085.4523092921845, 6088.695565221721, 6088.908666370008, 4562.931556026662, 4591.380163677927, 4611.2852507861335, 4632.444106707149, 4645.117427688729, 4153.709240353146, 4158.0, 4161.91676166481, 4176.9582304176565, 4204.957950420518, 5792.652440853562, 5794.710264486843, 5800.419958004166, 5805.709714514342, 5812.418758124154, 5926.822195334147, 5952.494038006731, 5993.130996005555, 6091.02543593023, 6104.877902441926, 5719.542436605062, 5755.539556835443, 5766.336871259775, 5791.0734282514595, 5809.2738407699035, 5166.844994650167, 5179.792808287626, 5189.844304670866, 5191.480851914778, 5227.424983251839, 6092.695365231721, 6134.723937422916, 6171.59884607499, 6222.004479283383, 6291.182146320949, 6018.638881667114, 6035.245594300713, 6067.029275315928, 6071.362506936708, 6103.938960610337, 6254.6165977919745, 6289.591176573508, 6290.150829637941, 6298.0867774171575, 6302.432781049728, 5803.39064398249, 5945.762169513344, 5947.434993675594, 5949.494292985145, 5976.880462390641, 5914.142449344907, 5981.671008094597, 6018.578699490994, 6038.0, 6084.787032453843, 5938.198343223782, 5940.732667030081, 5942.64344139353, 5944.464998150187, 5950.077737950624, 5903.675297858659, 5906.675132867562, 5929.99190137669, 5930.258717660293, 5934.258217722785, 5609.21470994053, 5723.742431590672, 5729.942700572941, 5776.768929242783, 5821.970890145522, 5977.581569290108, 5980.641161530322, 5982.670953097621, 5997.730102145501, 6015.669138197266, 5547.084731019337, 5595.5523558116065, 5840.94159058421, 5845.678487683218, 5855.0], "value": 5571.620785037665, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [591.9585629005969, 601.0863487499001, 632.9556931014828, 656.865342604766, 672.0322735261227, 45677.0, 47017.764911175436, 47026.999999999956, 47107.0, 51726.0, 48564.75717621407, 49215.0, 49244.0, 49246.75376623121, 49277.50722492774, 8488.78778030548, 8680.652773889069, 8689.826203475926, 8971.10288971101, 9073.727788166332, 8727.432716873383, 10744.409057501873, 11041.116710663127, 11050.557977680883, 11369.0, 11241.0, 11306.152038597096, 11308.03881670059, 11316.603918862842, 11320.0, 11087.55649774008, 11146.777064458705, 11149.442527873654, 11150.665480035612, 11167.888321116767, 11005.504752286086, 11057.281276716987, 11075.390853503053, 11101.611443599517, 11113.611023614134, 45118.77440612809, 45326.77336613329, 45328.3200751989, 45347.546524534664, 45468.54531454676, 3634.8727794527063, 3720.795356255405, 4236.639885609727, 4266.168097221043, 4348.782560871944, 31754.364912701847, 34009.6599034009, 34504.82747586271, 35124.29751404983, 35176.64823351759, 4434.73391596502, 4479.17135329965, 4504.121696269229, 4505.7296562206375, 4725.952740472586, 346023.0, 348036.0, 348058.0, 349201.0, 351413.0, 38701.612983870364, 66817.0, 67107.66446167738, 67128.66435667888, 67157.3284267151, 39432.21135577272, 41667.583324166975, 41989.0, 42056.57943420527, 42104.36843447351, 17145.742813857803, 17296.740548891776, 17304.134793260288, 17313.480595582154, 17317.4804755855, 13411.865881341257, 13618.18290902549, 14493.7825932609, 14592.562223133324, 14627.853721462649, 9360.485173315534, 9637.325387222827, 9643.08390702882, 9732.54011898221, 9777.071178238057, 3599.6040435552068, 3607.4228123500116, 3636.1818590816856, 3637.5998640149564, 3661.9267614647556, 1073.7100982734619, 1074.1621535202555, 1081.9459027048615, 1123.7246874515795, 1138.681169272605, 32452.67547324544, 33154.668453315644, 33171.83414082914, 33313.50029749556, 33702.49446258308, 1105.988020960828, 1156.8206927926185, 1165.8134698448207, 1173.6948393417772, 1212.9992755976355, 17488.0, 17519.73720394195, 17539.561510962074, 17643.647127057644, 17703.645927081387, 509809.0, 514915.0, 519405.0, 520118.0, 521581.0, 43166.56833431625, 43528.347074793906, 43566.56433435689, 43590.12819743587, 43600.78199608982, 1325.615571484278, 1377.9035467517178, 1402.929853507341, 1412.8445870954188, 1440.373437554688, 31985.0, 34185.82907085449, 34273.82863085669, 34361.14097147491, 34415.311693765485, 54494.18258726043, 55174.0, 55274.44725552693, 55276.0, 55296.44703552913, 379206.0, 381996.0, 382104.0, 382386.0, 382537.0, 27516.58725119085, 28150.155495335173, 28198.85900570484, 31017.0, 31699.207519811265, 41130.588694112674, 52564.73717631387, 52756.0, 53063.73468132634, 53533.73233133809, 42327.788361057996, 42638.0, 42960.0, 43520.0, 44879.32681009853, 41511.37732933948, 42595.0, 43388.34917476177, 43632.56367436285, 44741.55258447374, 41760.3735943955, 42572.36141457943, 43136.78431607947, 43767.56232437635, 43921.0, 35982.64017359898, 37810.0, 38259.80870095632, 38665.42001870031, 38956.41565376465, 27829.860850695615, 28408.289792755346, 28645.713542864305, 28796.71203288024, 28840.711592884643], "value": 20139.25906165522, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [422.06302009538814, 430.56837988771633, 435.09066051951413, 437.85769624871915, 446.7141029740968, 18778.15498302576, 19886.303979360706, 20402.59194816103, 20627.38117856467, 20786.688199677017, 20132.0, 20138.0, 20646.48383790406, 20647.483812904684, 20787.896060519714, 5790.276215473066, 6083.3612470690605, 6089.665068421235, 6096.0, 6096.664683442409, 5826.329972053205, 5924.466797988181, 5967.761289548413, 5991.880162396749, 6087.604305720136, 5891.381404952483, 5929.911051334234, 5930.288365396159, 5937.346891841894, 5937.7624895004365, 5725.227094342252, 5869.85325366865, 5909.556783241253, 5952.494038006775, 5968.31364393096, 5368.8389348319615, 5384.0, 5393.1370980642905, 5395.0, 5398.433164517708, 23797.524049519085, 23825.0, 23861.0, 23981.760182398128, 23998.640020399707, 2520.1809411941194, 2572.15119010726, 2600.2719238613217, 2645.8941642334285, 3167.825769582672, 14737.189454579993, 14789.926050369786, 15172.848271517254, 15226.543203703906, 15692.13693246871, 1931.6233334499777, 1993.6511110555596, 2016.3850025742142, 2018.414659748671, 2047.4369548374316, 82951.0, 84754.0, 85741.0, 86045.56977215137, 86237.0, 10363.533640986174, 10532.31539949916, 10712.250142489951, 11449.255798373079, 11451.423429728244, 16419.753703694456, 16441.506754797374, 16452.095134767704, 16453.42413015539, 16458.09480478561, 8730.432521886058, 8853.955730221307, 8940.597673104727, 8998.460092394478, 9042.231410330063, 8653.956730216309, 8700.0, 8771.132021727875, 8915.598798054103, 8982.550872456351, 7006.229314775371, 7019.543729657556, 7045.859082818315, 7046.401055910203, 7102.254263302382, 2086.1863873089505, 2087.7390326209224, 2104.5054412213117, 2118.2903727251237, 2146.6028784674886, 951.2104952889085, 966.6616684160488, 1013.5388398278766, 1028.6296933104077, 1061.124572227915, 19959.30956225286, 20283.290084847256, 20292.695609565868, 20366.796332036785, 20505.38483845487, 1033.178622994721, 1033.9224558158019, 1043.89561043895, 1086.7989421956963, 1112.799696054718, 10571.841422378671, 11485.942570287096, 11577.363245021605, 11602.535898564132, 11646.53413863453, 478149.0, 478153.0, 499157.0, 501431.0, 503273.0, 82734.0, 84656.0, 85083.9033536536, 85350.0, 85645.0, 1028.3315844700855, 1061.4162210784039, 1066.8826429092794, 1077.1705786544317, 1077.4612693653173, 16901.492955211364, 17139.0, 17830.37593684215, 17835.375761848274, 17916.193771280065, 44211.33682994694, 44602.0, 44657.33014004728, 45452.545474546154, 46884.29673554967, 55870.720646396505, 59280.40719592749, 60215.39784602273, 60855.39144608497, 61157.38842611517, 8776.868346974928, 8813.471191728517, 8959.238464730572, 8978.55107244622, 9171.63313467454, 7173.784786456415, 10029.796424429116, 13456.394462249027, 13730.725385492435, 14241.287935602972, 6346.270178929482, 11705.473253703434, 12252.938735306267, 12488.937555312164, 12496.500139994298, 11647.534098635959, 11740.119491038036, 12004.579839705568, 12234.755304893673, 12381.00951923862, 5818.44724751148, 6898.8620227596175, 11616.244944078946, 12123.939380303042, 12333.519977602746, 8631.180037896389, 8976.371653984159, 9067.68263110788, 9083.091690830865, 9127.0, 9514.524273786421, 11860.288382697066, 12006.0, 12020.579279725518, 12441.440135193758], "value": 9675.518871543241, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1380.613428240092, 1512.0, 1530.2707940027767, 1735.5921358480755, 1881.4449737327495, 7763.611819409028, 8739.606717697703, 8959.91040089599, 8978.147076027775, 9313.58088886, 9125.31560132991, 9172.357934944557, 9176.357654964138, 9206.217471514912, 9219.953900230506, 2492.0779311654715, 2517.546841568517, 2521.2688320387065, 2523.2430270918744, 2525.0783464035585, 2427.611582146857, 2512.4472616024445, 2516.169664010872, 2516.5218608464334, 2520.281719709874, 2470.7158676752224, 2481.0323973650293, 2493.551160791057, 2494.6008638617823, 2497.126005897939, 2343.61330380487, 2370.7747763962484, 2407.422218667516, 2427.538767634144, 2428.3322086426197, 2387.2599494156693, 2397.280815755284, 2427.3324835670155, 2431.367844360479, 2431.683881095464, 8799.12008799115, 9026.45841249527, 9097.818043639156, 9157.771055723593, 9250.907490925072, 5589.524890384322, 5728.942710572883, 5740.196372507852, 5742.7415766290615, 5744.368119506851, 3501.7898926064263, 3629.618890016563, 3629.909252268688, 3664.798436086014, 3667.8553234844453, 1194.2595590733802, 1196.8397043336774, 1219.5304807649031, 1229.201019337429, 1300.5383089003362, 12623.116381853273, 12667.429965651569, 12692.555760548428, 12710.745785084246, 12721.427535760913, 4605.470370907388, 4721.504242054535, 4862.927056094161, 4878.487758785347, 4879.609631229493, 9997.400155990665, 10019.849702254473, 10027.0, 10033.899661003443, 10037.849432258521, 5595.804146854922, 5602.243697100921, 5602.943970560324, 5604.075327570987, 5610.214569960209, 4293.91412171761, 4432.2908334666945, 4600.631949444037, 5009.5491405773655, 5196.428392876781, 4052.3313653247474, 4053.7365071270274, 4175.248455278079, 4190.329547272422, 4191.350340697197, 1223.7736018836545, 1253.4296894912793, 1259.0808709642013, 1263.9304838233802, 1264.1277518512197, 823.2014945502852, 824.9670013199525, 841.2302742990096, 917.1653795046476, 1008.3445760255893, 5681.062624666966, 5736.110902810071, 5783.045797443375, 5812.38969908162, 5887.882242355129, 893.848045832197, 915.5651065743718, 949.544218774978, 961.7307153996892, 999.9700308682069, 3872.903177420587, 3920.1017430986985, 3934.252492026506, 4054.9797251014147, 4090.6318431341324, 10348.689539313833, 11076.723081923017, 11102.555897764161, 11137.832932506019, 11144.721381965353, 10560.52477638508, 10848.18638602108, 11015.944920275348, 11066.446677666085, 11081.501332440059, 8535.103814099555, 8711.998120216129, 8760.386772925835, 8768.868466973001, 8776.385653004229, 5674.971625142013, 5972.910406343822, 5985.940140598538, 5990.371011043778, 6172.197614310111, 9847.113759761656, 10379.0, 10424.270301079156, 10428.843567346345, 10471.94764026175, 9153.130452606993, 9366.95316523413, 10316.27786054969, 10701.892981070401, 10711.785764284827, 7649.235076492307, 7801.2198780121535, 7865.0, 7996.080450748006, 8062.0, 8917.197452229331, 8953.104689531256, 8975.551222438982, 8986.775330616787, 8992.100789921216, 7806.0, 7929.484583502054, 8046.0747014091785, 8048.074471435626, 8073.273405393543, 7704.576248306397, 7808.6876524940635, 7876.881846772418, 7892.4869883457395, 7905.486143400661, 7246.1666908306215, 7319.597422141834, 7376.96311518439, 7380.1512826023545, 7383.0, 5015.1474249378425, 5023.095842748195, 5058.721770302669, 5071.898562028812, 5225.973870130625, 5197.870053248699, 5254.395744489279, 5259.342582177228, 5266.473352664703, 5505.119180931032], "value": 4756.316977861093, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.71042903103336, 340.3754111205937, 352.78832700379775, 358.78293632352444, 359.64035964035963, 5486.3690675572325, 5513.145462453316, 5517.36550296716, 5519.475649813271, 5537.778488860441, 5156.793728250866, 5233.467409498583, 5279.706471914376, 5306.151015837467, 5477.4796394342575, 4142.212979533879, 4167.52073511547, 4167.8541251056295, 4234.97882510587, 4281.272183728758, 4258.382534532491, 4275.636570891463, 4280.186764514748, 4299.548547402509, 4312.417823593822, 4123.876283711494, 4221.134667393192, 4223.429836972, 4240.130773191504, 4256.382824490447, 4174.415581818548, 4211.894702632443, 4223.282042052859, 4233.216854881826, 4240.491141063061, 3786.2048969716116, 3790.1851102012924, 3792.5069740933777, 3796.620337966209, 3807.2956503047026, 5053.523773351031, 5280.551153151987, 5281.841544753664, 5303.469653034705, 5311.7344132793205, 4854.902901941941, 4861.611071114337, 4864.7324397158145, 4864.854054378375, 4885.60915126789, 5664.111303235339, 5668.574856885709, 5675.63108397957, 5683.403242659544, 5686.715664216814, 4029.53660329063, 4099.139180772041, 4128.298189307825, 4138.772367519785, 4141.627253547165, 5828.504577110951, 5847.736851841635, 5857.297124345106, 5887.911681324784, 5892.882142357172, 4201.138766552849, 4205.306124489425, 4207.221663992172, 4215.346621273708, 4258.53156152823, 4100.6924480664065, 4211.915761684749, 4284.3145096784365, 4315.935260971088, 4317.287647538121, 4823.589994850407, 4835.008823191238, 4848.781804818721, 4857.368542089505, 4867.318575399447, 5728.541716662657, 5729.28383952006, 5743.295574354518, 5747.195392645033, 5751.798687046017, 1425.9928700356431, 1441.2145380767297, 1457.5554455891056, 1458.50410860308, 1475.3139789997704, 976.1556253840519, 987.2891518106951, 994.2443742755557, 998.55065220651, 1011.4841430870162, 5267.578593712494, 5309.283246761638, 5329.8934021319355, 5330.760115794721, 5331.466853314715, 5551.001639409809, 5575.386707462176, 5637.49262566371, 5662.009148399014, 5677.716114194273, 5148.722036769528, 5229.973850130725, 5265.578293860636, 5269.525742683177, 5328.001999250281, 2980.5231163014246, 2992.730654241129, 2995.550667399864, 2996.700329966986, 3003.4293484237924, 5758.510526605201, 5788.842231553622, 5805.94194058054, 5824.912626310609, 5851.912221316684, 5455.509004189642, 5638.323401191883, 5659.632123912015, 5682.176084467812, 5710.829279997591, 5776.855578610484, 5791.305043394819, 5791.82624521265, 5808.738606762706, 5843.970780146072, 5349.812756553502, 5617.601351182476, 5623.297087864017, 5625.409332020243, 5653.773849046157, 5550.361708403585, 5550.584600926738, 5567.415421380697, 5571.66570005801, 5578.916316255179, 5809.419058094157, 5823.18475413451, 5842.444967728059, 5854.795082172103, 5867.9413205869105, 3935.724499285137, 4078.734882232764, 4105.2405305018665, 4106.445629840053, 4132.5454200038575, 5607.523360514238, 5704.914426283692, 5730.369659337553, 5759.51044161251, 5829.912551311649, 5678.829635110953, 5680.68756218412, 5728.856778580569, 5730.799422020209, 5738.8278351649515, 5508.669479831223, 5636.351819540805, 5683.488486036276, 5704.743286552032, 5705.6021274787945, 5625.803096891753, 5634.32388113429, 5670.958454956295, 5672.858178545569, 5676.4323567642905, 5665.263515743092, 5709.600327977002, 5728.828135155952, 5754.0297194935365, 5764.769409223584, 5404.2163886235485, 5536.584756143225, 5565.777368905198, 5566.409665765639, 5575.4424557543925], "value": 4306.782873567032, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [725.8403151306711, 761.7562380038387, 804.5574933786417, 816.1960468938099, 869.7173418638941, 14897.77653335201, 15433.0, 15737.685246295066, 15838.28727707253, 16256.51230463088, 13667.111637743565, 13946.860531394708, 13985.720285594281, 13995.580132596013, 14032.087914285565, 733.3546479098386, 847.5296210603112, 859.1365677494109, 859.166608389864, 859.3726579596898, 747.4655621230819, 840.9243168114868, 854.7734850264685, 862.0818827948215, 862.7196161247588, 895.879056327394, 904.1410659873147, 907.4373888189332, 907.5008745190152, 907.9273658107336, 905.5924833824805, 905.8777065096259, 910.4582773249906, 910.7677542226756, 911.5715613661569, 672.5729161982127, 674.6222115615271, 674.9831254218684, 675.5541342713834, 675.7769935921134, 14649.12105273687, 14870.479533216285, 14888.70222595542, 14902.776458353133, 15502.147381894105, 14787.0, 15063.623409414742, 15514.61213469661, 15540.456084037005, 15615.609609759733, 11622.186446948717, 11701.824472632918, 11724.88275117255, 11768.0, 11792.174547781658, 3737.3085979093953, 3796.1648437343742, 3803.2013277211818, 3857.112864041258, 3890.4164375343644, 66368.3363166367, 67058.0, 67398.66300668515, 67628.6618566904, 68005.0, 10930.945345273223, 11082.390468524309, 11108.722281943015, 11171.532339690735, 11175.44122793857, 19690.40928772139, 19751.111199995747, 19781.30765423232, 19932.70100948487, 19956.10197541114, 7794.883076753853, 7866.09539902907, 8070.47541909774, 8086.070101938352, 8134.511929284262, 4567.063751930847, 4575.290829921368, 4619.284010978236, 4629.421322334708, 4761.595264402496, 3310.66893310667, 3421.196018935548, 3424.4863270509622, 3426.503157042265, 3426.674465925733, 612.8958077126899, 614.58208418276, 617.3147805935408, 627.6924307089585, 629.2071989293523, 550.5870448356427, 597.3817099302202, 654.5287393077073, 665.2682049745241, 668.9163854518185, 8586.656533738706, 8905.821883562292, 9076.727698169065, 9114.453132812052, 9194.540272986324, 603.2579926690196, 624.2508989212963, 637.8692368064536, 649.5226008883467, 653.4413076819251, 4072.165206132736, 4272.722273052242, 4278.229918614679, 4379.693421460467, 4466.731996080245, 82796.58601706952, 83806.58096709478, 85767.5711621438, 88292.0, 88974.55512722525, 74263.0, 76328.23671763322, 78636.21363786403, 78984.21015789884, 79334.20665793384, 59733.22134229251, 70825.0, 71264.64367678128, 71622.28377716156, 72032.63983680152, 8512.233898949124, 9028.503432311287, 9145.542722863964, 9192.908070919206, 9269.814603708022, 32889.34221315608, 33810.0, 43020.78489607532, 44525.0, 46957.765211173726, 60284.0, 61873.0, 62208.57852818139, 62433.68783156055, 62950.0, 12549.874501255235, 12626.116171867881, 12711.0, 12762.42569084375, 12820.743585128432, 13766.862331376558, 13965.58103256904, 14059.367328470038, 14087.295635217994, 14151.504697335544, 12748.808767868304, 12826.294553799631, 12848.871511284768, 13032.674183145118, 13156.868431315947, 12917.56807161507, 12974.351282435651, 13040.673983150496, 13115.081944264191, 13264.475121660618, 11897.881021189678, 11901.345426001306, 11903.0, 12105.455254513392, 12232.633021009384, 10157.593696252066, 10334.018268264503, 10613.681589552325, 10695.893041069801, 11094.167937404565, 10700.304480209074, 11012.449377530931, 11100.888991109985, 11156.274842135235, 11211.943940280247], "value": 7136.557775141831, "unit": "score"}], "name": "dromaeo_css", "value": 7358.272263201745, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 112.0, 111.0, 112.0, 114.0, 111.0, 110.0, 112.0, 111.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 118.0, 119.0, 167.0, 123.0, 118.0, 121.0, 117.0, 150.0, 118.0], "value": 131.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 159.0, 160.0, 159.0, 159.0, 159.0, 158.0, 163.0, 158.0], "value": 159.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 74.0, 102.0, 77.0, 75.0, 76.0, 75.0, 100.0, 74.0], "value": 80.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 82.0, 121.0, 82.0, 81.0, 82.0, 103.0, 81.0, 80.0, 118.0], "value": 91.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 145.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 85.0, 84.0, 84.0, 84.0, 85.0, 84.0, 84.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 51.0, 51.0, 52.0, 50.0, 50.0, 50.0, 50.0, 50.0, 49.0], "value": 50.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 58.0, 59.0, 59.0, 59.0, 59.0, 58.0, 59.0, 58.0], "value": 58.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 73.0, 77.0, 79.0, 74.0, 73.0, 74.0, 74.0, 73.0, 75.0], "value": 74.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 127.0, 121.0, 122.0, 120.0, 127.0, 131.0, 116.0, 159.0, 124.0], "value": 127.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 154.0, 152.0, 157.0, 153.0, 159.0, 158.0, 157.0, 150.0, 156.0], "value": 154.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 63.0, 61.0, 63.0, 67.0, 63.0, 63.0, 61.0, 61.0], "value": 62.7, "unit": "score"}], "name": "kraken", "value": 1448.6, "alertThreshold": 2.0}]} 16:09:41 INFO - Return code: 0 16:09:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:09:41 INFO - # TBPL SUCCESS # 16:09:41 INFO - Running post-action listener: _resource_record_post_action 16:09:41 INFO - [mozharness: 2017-03-02 00:09:41.641226Z] Finished run-tests step (success) 16:09:41 INFO - Running post-run listener: _resource_record_post_run 16:09:41 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 196608; Write bytes: 340213760; Read time: 44; Write time: 345104 16:09:41 INFO - TinderboxPrint: CPU usage
13.0% 16:09:41 INFO - TinderboxPrint: I/O read bytes / time
196,608 / 44 16:09:41 INFO - TinderboxPrint: I/O write bytes / time
340,213,760 / 345,104 16:09:41 INFO - TinderboxPrint: CPU idle
8,263.6 (87.0%) 16:09:41 INFO - TinderboxPrint: CPU user
1,189.8 (12.5%) 16:09:41 INFO - TinderboxPrint: Swap in / out
0 / 0 16:09:41 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 101294080; Read time: 0; Write time: 115080 16:09:41 INFO - run-tests - Wall time: 1177s; CPU: 13.0%; Read bytes: 196608; Write bytes: 219578368; Read time: 44; Write time: 211048 16:09:42 INFO - Running post-run listener: _upload_blobber_files 16:09:42 INFO - Blob upload gear active. 16:09:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:09:42 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 16:09:42 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:09:42 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:09:42 INFO - (blobuploader) - INFO - Open directory for files ... 16:09:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:09:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:09:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:45 INFO - (blobuploader) - INFO - Done attempting. 16:09:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:09:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:09:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:46 INFO - (blobuploader) - INFO - Done attempting. 16:09:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:09:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:09:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:09:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:09:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:09:47 INFO - (blobuploader) - INFO - Done attempting. 16:09:47 INFO - (blobuploader) - INFO - Iteration through files over. 16:09:47 INFO - Return code: 0 16:09:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:09:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:09:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/70c2a8d76c3628e79bbc564368142c132b3bdac188323441c7bcdc41f3059c1d450226caf0f231767b08e492b4dbef3ee087fa0a3166ef5fad032a966415f206", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9297b9349225e77700bd595bea8f18644a936feeea1b7b7edd7a01cc45771ba20da541fca0b62b4b1c1ae006046eb01dbc1faa8c3a757d6009cfe05a568239f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2e8e9f56270f1e83bc556fb88b554a591a283b177098bf6185237e183d3acde8e16279b9abe4f05463efaf7b3f9fe42c7b28f079878f908f6d49da0e592a1ff3"} 16:09:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:09:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:09:47 INFO - Contents: 16:09:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/70c2a8d76c3628e79bbc564368142c132b3bdac188323441c7bcdc41f3059c1d450226caf0f231767b08e492b4dbef3ee087fa0a3166ef5fad032a966415f206", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9297b9349225e77700bd595bea8f18644a936feeea1b7b7edd7a01cc45771ba20da541fca0b62b4b1c1ae006046eb01dbc1faa8c3a757d6009cfe05a568239f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2e8e9f56270f1e83bc556fb88b554a591a283b177098bf6185237e183d3acde8e16279b9abe4f05463efaf7b3f9fe42c7b28f079878f908f6d49da0e592a1ff3"} 16:09:47 INFO - Running post-run listener: copy_logs_to_upload_dir 16:09:47 INFO - Copying logs to upload dir... 16:09:47 INFO - mkdir: /builds/slave/test/build/upload/logs 16:09:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.352893 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2017-03-01 16:09:47.754808) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-01 16:09:47.758177) ========= 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=df17445c3590ff7897617a0e00000225-1488406134.439901-982370674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/70c2a8d76c3628e79bbc564368142c132b3bdac188323441c7bcdc41f3059c1d450226caf0f231767b08e492b4dbef3ee087fa0a3166ef5fad032a966415f206", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9297b9349225e77700bd595bea8f18644a936feeea1b7b7edd7a01cc45771ba20da541fca0b62b4b1c1ae006046eb01dbc1faa8c3a757d6009cfe05a568239f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2e8e9f56270f1e83bc556fb88b554a591a283b177098bf6185237e183d3acde8e16279b9abe4f05463efaf7b3f9fe42c7b28f079878f908f6d49da0e592a1ff3"} build_url:https://queue.taskcluster.net/v1/task/fUrovAjkRRC2WGtUulPscQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011367 build_url: 'https://queue.taskcluster.net/v1/task/fUrovAjkRRC2WGtUulPscQ/artifacts/public/build/firefox-52.0.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/70c2a8d76c3628e79bbc564368142c132b3bdac188323441c7bcdc41f3059c1d450226caf0f231767b08e492b4dbef3ee087fa0a3166ef5fad032a966415f206", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9297b9349225e77700bd595bea8f18644a936feeea1b7b7edd7a01cc45771ba20da541fca0b62b4b1c1ae006046eb01dbc1faa8c3a757d6009cfe05a568239f7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2e8e9f56270f1e83bc556fb88b554a591a283b177098bf6185237e183d3acde8e16279b9abe4f05463efaf7b3f9fe42c7b28f079878f908f6d49da0e592a1ff3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-01 16:09:47.784174) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 16:09:47.784560) ========= 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=df17445c3590ff7897617a0e00000225-1488406134.439901-982370674 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004436 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-01 16:09:47.865862) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-01 16:09:47.866225) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-01 16:09:47.866603) ========= ========= Total master_lag: 0.30 =========