builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-029 starttime: 1486352732.02 results: success (0) revision: 2085bd699dbdf9ec22bf98adcecb4b8ffd099bed ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-05 19:45:32.016762) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-05 19:45:32.017209) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-05 19:45:32.017487) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-05 19:45:32.380771) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:45:32.381086) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-05 19:45:33-- 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% 47.9K=0.2s 2017-02-05 19:45:33 (47.9 KB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.376427 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:45:32.773811) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:45:32.774137) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015267 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 19:45:32.829328) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-05 19:45:32.829666) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2085bd699dbdf9ec22bf98adcecb4b8ffd099bed --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 2085bd699dbdf9ec22bf98adcecb4b8ffd099bed --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-05 19:45:33,765 truncating revision to first 12 chars 2017-02-05 19:45:33,765 Setting DEBUG logging. 2017-02-05 19:45:33,765 attempt 1/10 2017-02-05 19:45:33,765 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/2085bd699dbd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-05 19:45:34,589 unpacking tar archive at: mozilla-aurora-2085bd699dbd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.096547 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-05 19:45:33.938894) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-05 19:45:33.939201) ========= script_repo_revision: 2085bd699dbdf9ec22bf98adcecb4b8ffd099bed ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-05 19:45:33.939569) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-05 19:45:33.939854) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-05 19:45:33.948488) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-05 19:45:33.948771) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:45:34 INFO - MultiFileLogger online at 20170205 19:45:34 in /builds/slave/test 19:45:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora-Non-PGO 19:45:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:45:34 INFO - {'append_to_log': False, 19:45:34 INFO - 'base_work_dir': '/builds/slave/test', 19:45:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 19:45:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:45:34 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 19:45:34 INFO - 'buildbot_json_path': 'buildprops.json', 19:45:34 INFO - 'config_files': ('talos/linux_config.py',), 19:45:34 INFO - 'default_actions': ('clobber', 19:45:34 INFO - 'read-buildbot-config', 19:45:34 INFO - 'download-and-extract', 19:45:34 INFO - 'populate-webroot', 19:45:34 INFO - 'create-virtualenv', 19:45:34 INFO - 'install', 19:45:34 INFO - 'run-tests'), 19:45:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:45:34 INFO - 'download_minidump_stackwalk': True, 19:45:34 INFO - 'download_symbols': 'ondemand', 19:45:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:45:34 INFO - 'tooltool.py': '/tools/tooltool.py', 19:45:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:45:34 INFO - '/tools/misc-python/virtualenv.py')}, 19:45:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:45:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:45:34 INFO - 'installer_path': 'installer.exe', 19:45:34 INFO - 'log_level': 'info', 19:45:34 INFO - 'log_name': 'talos', 19:45:34 INFO - 'log_to_console': True, 19:45:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:45:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:45:34 INFO - 'opt_config_files': (), 19:45:34 INFO - 'pip_index': False, 19:45:34 INFO - 'sps_profile': False, 19:45:34 INFO - 'sps_profile_interval': 0, 19:45:34 INFO - 'suite': 'dromaeojs-e10s', 19:45:34 INFO - 'system_bits': '32', 19:45:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:45:34 INFO - 'title': 'talos-linux64-ix-029', 19:45:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:45:34 INFO - 'use_talos_json': True, 19:45:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:45:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:45:34 INFO - 'work_dir': 'build'} 19:45:34 INFO - [mozharness: 2017-02-06 03:45:34.982391Z] Running clobber step. 19:45:34 INFO - Running pre-action listener: _resource_record_pre_action 19:45:34 INFO - Running main action method: clobber 19:45:34 INFO - rmtree: /builds/slave/test/build 19:45:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:45:35 INFO - Running post-action listener: _resource_record_post_action 19:45:35 INFO - [mozharness: 2017-02-06 03:45:35.453920Z] Finished clobber step (success) 19:45:35 INFO - [mozharness: 2017-02-06 03:45:35.454020Z] Running read-buildbot-config step. 19:45:35 INFO - Running pre-action listener: _resource_record_pre_action 19:45:35 INFO - Running main action method: read_buildbot_config 19:45:35 INFO - Using buildbot properties: 19:45:35 INFO - { 19:45:35 INFO - "project": "", 19:45:35 INFO - "product": "firefox", 19:45:35 INFO - "who": "hikezoe@mozilla.com", 19:45:35 INFO - "installer_path": "public/build/target.tar.bz2", 19:45:35 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 19:45:35 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 19:45:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs-e10s", 19:45:35 INFO - "stage_platform": "linux64", 19:45:35 INFO - "basedir": "/builds/slave/test", 19:45:35 INFO - "buildnumber": 22, 19:45:35 INFO - "platform": "ubuntu64_hw", 19:45:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 19:45:35 INFO - "slavebuilddir": "test", 19:45:35 INFO - "taskId": "YYD2qb4nSqmlTKiJE0TvPw", 19:45:35 INFO - "branch": "mozilla-aurora", 19:45:35 INFO - "script_repo_revision": "production", 19:45:35 INFO - "revision": "2085bd699dbdf9ec22bf98adcecb4b8ffd099bed", 19:45:35 INFO - "slavename": "talos-linux64-ix-029", 19:45:35 INFO - "repo_path": "releases/mozilla-aurora" 19:45:35 INFO - } 19:45:35 INFO - Finding installer, test and symbols from parent task. 19:45:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YYD2qb4nSqmlTKiJE0TvPw'}, attempt #1 19:45:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YYD2qb4nSqmlTKiJE0TvPw'}, attempt #1 19:45:36 INFO - Task dependencies: Ec9SgxE9RTuHf4JZE_3-bQ 19:45:36 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ'}, attempt #1 19:45:36 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ/artifacts/public/build/target.tar.bz2 19:45:36 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ/artifacts/public/build/test_packages.json 19:45:36 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ/artifacts/public/build/target.crashreporter-symbols.zip 19:45:36 INFO - Running post-action listener: _resource_record_post_action 19:45:36 INFO - [mozharness: 2017-02-06 03:45:36.828289Z] Finished read-buildbot-config step (success) 19:45:36 INFO - [mozharness: 2017-02-06 03:45:36.828506Z] Running download-and-extract step. 19:45:36 INFO - Running pre-action listener: _resource_record_pre_action 19:45:36 INFO - Running main action method: download_and_extract 19:45:36 INFO - mkdir: /builds/slave/test/build/tests 19:45: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')]} 19:45:36 INFO - trying https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ/artifacts/public/build/target.test_packages.json 19:45:36 INFO - Downloading https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:45:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:45:37 INFO - Downloaded 896 bytes. 19:45:37 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:45:37 INFO - Using the following test package requirements: 19:45:37 INFO - {u'common': [u'target.common.tests.zip'], 19:45:37 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:45:37 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:45:37 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:45:37 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:45:37 INFO - u'mozbase': [u'target.common.tests.zip'], 19:45:37 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:45:37 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:45:37 INFO - u'web-platform': [u'target.common.tests.zip', 19:45:37 INFO - u'target.web-platform.tests.zip'], 19:45:37 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:45:37 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:45:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ/artifacts/public/build/target.common.tests.zip 19:45:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:45:37 INFO - Fetch https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ/artifacts/public/build/target.common.tests.zip into memory 19:45:38 INFO - Expected file size: 21854975 19:45:38 INFO - Obtained file size: 21854975 19:45:42 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:45:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ/artifacts/public/build/target.common.tests.zip 19:45:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:45:42 INFO - Fetch https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ/artifacts/public/build/target.common.tests.zip into memory 19:45:42 INFO - Expected file size: 21854975 19:45:42 INFO - Obtained file size: 21854975 19:45:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ/artifacts/public/build/target.talos.tests.zip 19:45:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:45:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ/artifacts/public/build/target.talos.tests.zip into memory 19:45:48 INFO - Expected file size: 14403485 19:45:48 INFO - Obtained file size: 14403485 19:45:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:45:48 INFO - trying https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ/artifacts/public/build/target.tar.bz2 19:45:48 INFO - Downloading https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:45:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:45:49 INFO - Downloaded 66062047 bytes. 19:45:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ/artifacts/public/build/target.tar.bz2 19:45:49 INFO - mkdir: /builds/slave/test/properties 19:45:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:45:49 INFO - Writing to file /builds/slave/test/properties/build_url 19:45:49 INFO - Contents: 19:45:49 INFO - build_url:https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ/artifacts/public/build/target.tar.bz2 19:45:49 INFO - Running post-action listener: _resource_record_post_action 19:45:49 INFO - Running post-action listener: set_extra_try_arguments 19:45:49 INFO - [mozharness: 2017-02-06 03:45:49.738246Z] Finished download-and-extract step (success) 19:45:49 INFO - [mozharness: 2017-02-06 03:45:49.738343Z] Running populate-webroot step. 19:45:49 INFO - Running pre-action listener: _resource_record_pre_action 19:45:49 INFO - Running main action method: populate_webroot 19:45:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:45:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:45:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:45:49 INFO - '--tppagecycles', 19:45:49 INFO - '7'], 19:45:49 INFO - 'tests': ['tsvgm']}}, 19:45:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:45:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:45:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:45:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:45:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:45:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:45:49 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:45:49 INFO - 'talos_options': ['--disable-e10s'], 19:45:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:45:49 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:45:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:45:49 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:45:49 INFO - 'talos_options': ['--disable-e10s'], 19:45:49 INFO - 'tests': ['damp', 'tps']}, 19:45:49 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:45:49 INFO - 'tests': ['damp', 'tps']}, 19:45:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:45:49 INFO - 'tests': ['dromaeo_dom']}, 19:45:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:45:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:45:49 INFO - 'tests': ['basic_compositor_video']}, 19:45:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:45:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:45:49 INFO - 'tests': ['a11yr', 19:45:49 INFO - 'ts_paint', 19:45:49 INFO - 'tpaint', 19:45:49 INFO - 'sessionrestore', 19:45:49 INFO - 'sessionrestore_no_auto_restore', 19:45:49 INFO - 'tabpaint']}, 19:45:49 INFO - 'other-e10s': {'tests': ['a11yr', 19:45:49 INFO - 'ts_paint', 19:45:49 INFO - 'tpaint', 19:45:49 INFO - 'sessionrestore', 19:45:49 INFO - 'sessionrestore_no_auto_restore', 19:45:49 INFO - 'tabpaint']}, 19:45:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:45:49 INFO - 'ts_paint', 19:45:49 INFO - 'tpaint', 19:45:49 INFO - 'sessionrestore', 19:45:49 INFO - 'sessionrestore_no_auto_restore', 19:45:49 INFO - 'tabpaint']}, 19:45:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:45:49 INFO - 'ts_paint', 19:45:49 INFO - 'tpaint', 19:45:49 INFO - 'sessionrestore', 19:45:49 INFO - 'sessionrestore_no_auto_restore', 19:45:49 INFO - 'tabpaint']}, 19:45:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:45:49 INFO - 'tests': ['a11yr', 19:45:49 INFO - 'ts_paint', 19:45:49 INFO - 'tpaint', 19:45:49 INFO - 'sessionrestore', 19:45:49 INFO - 'sessionrestore_no_auto_restore', 19:45:49 INFO - 'tabpaint']}, 19:45:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:45:49 INFO - 'tests': ['a11yr', 19:45:49 INFO - 'ts_paint', 19:45:49 INFO - 'tpaint', 19:45:49 INFO - 'sessionrestore', 19:45:49 INFO - 'sessionrestore_no_auto_restore', 19:45:49 INFO - 'tabpaint']}, 19:45:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:45:49 INFO - 'tests': ['tsvgx', 19:45:49 INFO - 'tsvgr_opacity', 19:45:49 INFO - 'tart', 19:45:49 INFO - 'tscrollx', 19:45:49 INFO - 'cart', 19:45:49 INFO - 'tsvg_static']}, 19:45:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:45:49 INFO - 'tsvgr_opacity', 19:45:49 INFO - 'tart', 19:45:49 INFO - 'tscrollx', 19:45:49 INFO - 'cart', 19:45:49 INFO - 'tsvg_static']}, 19:45:49 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:45:49 INFO - 'talos_options': ['--disable-e10s'], 19:45:49 INFO - 'tests': ['tp5o']}, 19:45:49 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:45:49 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:45:49 INFO - 'talos_options': ['--disable-e10s', 19:45:49 INFO - '--xperf_path', 19:45:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:45:49 INFO - 'tests': ['tp5n']}, 19:45:49 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:45:49 INFO - 'talos_options': ['--xperf_path', 19:45:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:45:49 INFO - 'tests': ['tp5n']}}, 19:45:49 INFO - 'talos.zip': {'path': '', 19:45:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:45:49 INFO - Running post-action listener: _resource_record_post_action 19:45:49 INFO - [mozharness: 2017-02-06 03:45:49.751444Z] Finished populate-webroot step (success) 19:45:49 INFO - [mozharness: 2017-02-06 03:45:49.751533Z] Running create-virtualenv step. 19:45:49 INFO - Running pre-action listener: _resource_record_pre_action 19:45:49 INFO - Running main action method: create_virtualenv 19:45:49 INFO - Creating virtualenv /builds/slave/test/build/venv 19:45:49 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 19:45:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:45:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:45:49 INFO - Using real prefix '/usr' 19:45:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:45:50 INFO - Installing distribute.............................................................................................................................................................................................done. 19:45:52 INFO - Installing pip.................done. 19:45:52 INFO - Return code: 0 19:45:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:45:52 INFO - Reading from file tmpfile_stdout 19:45:52 INFO - Output received: 19:45:52 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) 19:45:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:52 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 0x23d31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2745980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2742d00>, '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 0x2743a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2743eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926', '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 19:45:52 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 19:45:52 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 19:45:52 INFO - Using env: {'DISPLAY': ':0', 19:45:52 INFO - 'HOME': '/home/cltbld', 19:45:52 INFO - 'LANG': 'en_US.UTF-8', 19:45:52 INFO - 'LANGUAGE': 'en_US:en', 19:45:52 INFO - 'LOGNAME': 'cltbld', 19:45:52 INFO - 'MAIL': '/var/mail/cltbld', 19:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:52 INFO - 'MOZ_NO_REMOTE': '1', 19:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:52 INFO - 'NO_EM_RESTART': '1', 19:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:45:52 INFO - 'PWD': '/builds/slave/test', 19:45:52 INFO - 'SHELL': '/bin/bash', 19:45:52 INFO - 'SHLVL': '1', 19:45:52 INFO - 'TERM': 'linux', 19:45:52 INFO - 'TMOUT': '86400', 19:45:52 INFO - 'USER': 'cltbld', 19:45:52 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926', 19:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:52 INFO - '_': '/tools/buildbot/bin/python'} 19:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:52 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 19:45:52 INFO - Cleaning up... 19:45:52 INFO - Return code: 0 19:45:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:52 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 0x23d31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2745980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2742d00>, '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 0x2743a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2743eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926', '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 19:45:52 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 19:45:52 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 19:45:52 INFO - Using env: {'DISPLAY': ':0', 19:45:52 INFO - 'HOME': '/home/cltbld', 19:45:52 INFO - 'LANG': 'en_US.UTF-8', 19:45:52 INFO - 'LANGUAGE': 'en_US:en', 19:45:52 INFO - 'LOGNAME': 'cltbld', 19:45:52 INFO - 'MAIL': '/var/mail/cltbld', 19:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:52 INFO - 'MOZ_NO_REMOTE': '1', 19:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:52 INFO - 'NO_EM_RESTART': '1', 19:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:45:52 INFO - 'PWD': '/builds/slave/test', 19:45:52 INFO - 'SHELL': '/bin/bash', 19:45:52 INFO - 'SHLVL': '1', 19:45:52 INFO - 'TERM': 'linux', 19:45:52 INFO - 'TMOUT': '86400', 19:45:52 INFO - 'USER': 'cltbld', 19:45:52 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926', 19:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:52 INFO - '_': '/tools/buildbot/bin/python'} 19:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:52 INFO - Downloading/unpacking psutil>=3.1.1 19:45:52 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 19:45:52 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 19:45:52 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 19:45:52 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 19:45:52 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 19:45:52 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 19:45:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:45:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:45:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:45:55 INFO - Installing collected packages: psutil 19:45:55 INFO - Running setup.py install for psutil 19:45:55 INFO - building 'psutil._psutil_linux' extension 19:45:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:45:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:45:55 INFO - building 'psutil._psutil_posix' extension 19:45:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:45:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:45:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:45:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:45:55 INFO - Successfully installed psutil 19:45:55 INFO - Cleaning up... 19:45:55 INFO - Return code: 0 19:45:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:55 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 0x23d31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2745980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2742d00>, '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 0x2743a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2743eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926', '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 19:45:55 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 19:45:55 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 19:45:55 INFO - Using env: {'DISPLAY': ':0', 19:45:55 INFO - 'HOME': '/home/cltbld', 19:45:55 INFO - 'LANG': 'en_US.UTF-8', 19:45:55 INFO - 'LANGUAGE': 'en_US:en', 19:45:55 INFO - 'LOGNAME': 'cltbld', 19:45:55 INFO - 'MAIL': '/var/mail/cltbld', 19:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:55 INFO - 'MOZ_NO_REMOTE': '1', 19:45:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:55 INFO - 'NO_EM_RESTART': '1', 19:45:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:45:55 INFO - 'PWD': '/builds/slave/test', 19:45:55 INFO - 'SHELL': '/bin/bash', 19:45:55 INFO - 'SHLVL': '1', 19:45:55 INFO - 'TERM': 'linux', 19:45:55 INFO - 'TMOUT': '86400', 19:45:55 INFO - 'USER': 'cltbld', 19:45:55 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926', 19:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:55 INFO - '_': '/tools/buildbot/bin/python'} 19:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:45:55 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 19:45:55 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 19:45:55 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 19:45:55 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 19:45:55 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 19:45:55 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 19:45:58 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:45:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:45:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:45:58 INFO - Installing collected packages: mozsystemmonitor 19:45:58 INFO - Running setup.py install for mozsystemmonitor 19:45:58 INFO - Successfully installed mozsystemmonitor 19:45:58 INFO - Cleaning up... 19:45:58 INFO - Return code: 0 19:45:58 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:45:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:45:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:45:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:45:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23d31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2745980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2742d00>, '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 0x2743a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2743eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926', '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 19:45:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:45:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:45:58 INFO - Using env: {'DISPLAY': ':0', 19:45:58 INFO - 'HOME': '/home/cltbld', 19:45:58 INFO - 'LANG': 'en_US.UTF-8', 19:45:58 INFO - 'LANGUAGE': 'en_US:en', 19:45:58 INFO - 'LOGNAME': 'cltbld', 19:45:58 INFO - 'MAIL': '/var/mail/cltbld', 19:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:45:58 INFO - 'MOZ_NO_REMOTE': '1', 19:45:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:45:58 INFO - 'NO_EM_RESTART': '1', 19:45:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:45:58 INFO - 'PWD': '/builds/slave/test', 19:45:58 INFO - 'SHELL': '/bin/bash', 19:45:58 INFO - 'SHLVL': '1', 19:45:58 INFO - 'TERM': 'linux', 19:45:58 INFO - 'TMOUT': '86400', 19:45:58 INFO - 'USER': 'cltbld', 19:45:58 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926', 19:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:45:58 INFO - '_': '/tools/buildbot/bin/python'} 19:45:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:45:58 INFO - Downloading/unpacking jsonschema==2.5.1 19:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:45:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:45:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:46:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:46:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:46:00 INFO - Downloading functools32-3.2.3-2.tar.gz 19:46:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:46:00 INFO - warning: no files found matching '*.txt' 19:46:00 INFO - no previously-included directories found matching 'build' 19:46:00 INFO - no previously-included directories found matching 'dist' 19:46:00 INFO - no previously-included directories found matching '.git*' 19:46:00 INFO - Installing collected packages: jsonschema, functools32 19:46:00 INFO - Running setup.py install for functools32 19:46:00 INFO - warning: no files found matching '*.txt' 19:46:00 INFO - no previously-included directories found matching 'build' 19:46:00 INFO - no previously-included directories found matching 'dist' 19:46:00 INFO - no previously-included directories found matching '.git*' 19:46:00 INFO - Successfully installed jsonschema functools32 19:46:00 INFO - Cleaning up... 19:46:00 INFO - Return code: 0 19:46:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:46:00 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')]} 19:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:00 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')]} 19:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:00 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 0x23d31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2745980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2742d00>, '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 0x2743a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2743eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926', '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 19:46:00 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 19:46:00 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 19:46:01 INFO - Using env: {'DISPLAY': ':0', 19:46:01 INFO - 'HOME': '/home/cltbld', 19:46:01 INFO - 'LANG': 'en_US.UTF-8', 19:46:01 INFO - 'LANGUAGE': 'en_US:en', 19:46:01 INFO - 'LOGNAME': 'cltbld', 19:46:01 INFO - 'MAIL': '/var/mail/cltbld', 19:46:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:01 INFO - 'MOZ_NO_REMOTE': '1', 19:46:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:01 INFO - 'NO_EM_RESTART': '1', 19:46:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:01 INFO - 'PWD': '/builds/slave/test', 19:46:01 INFO - 'SHELL': '/bin/bash', 19:46:01 INFO - 'SHLVL': '1', 19:46:01 INFO - 'TERM': 'linux', 19:46:01 INFO - 'TMOUT': '86400', 19:46:01 INFO - 'USER': 'cltbld', 19:46:01 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926', 19:46:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:01 INFO - '_': '/tools/buildbot/bin/python'} 19:46:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:01 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:46:01 INFO - Cleaning up... 19:46:01 INFO - Return code: 0 19:46:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:46:01 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')]} 19:46:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:01 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')]} 19:46:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:01 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 0x23d31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2745980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2742d00>, '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 0x2743a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2743eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926', '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 19:46:01 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 19:46:01 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 19:46:01 INFO - Using env: {'DISPLAY': ':0', 19:46:01 INFO - 'HOME': '/home/cltbld', 19:46:01 INFO - 'LANG': 'en_US.UTF-8', 19:46:01 INFO - 'LANGUAGE': 'en_US:en', 19:46:01 INFO - 'LOGNAME': 'cltbld', 19:46:01 INFO - 'MAIL': '/var/mail/cltbld', 19:46:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:01 INFO - 'MOZ_NO_REMOTE': '1', 19:46:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:01 INFO - 'NO_EM_RESTART': '1', 19:46:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:01 INFO - 'PWD': '/builds/slave/test', 19:46:01 INFO - 'SHELL': '/bin/bash', 19:46:01 INFO - 'SHLVL': '1', 19:46:01 INFO - 'TERM': 'linux', 19:46:01 INFO - 'TMOUT': '86400', 19:46:01 INFO - 'USER': 'cltbld', 19:46:01 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926', 19:46:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:01 INFO - '_': '/tools/buildbot/bin/python'} 19:46:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:01 INFO - Downloading/unpacking blobuploader==1.2.4 19:46:01 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 19:46:01 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 19:46:01 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 19:46:01 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 19:46:01 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 19:46:01 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 19:46:03 INFO - Downloading blobuploader-1.2.4.tar.gz 19:46:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:46:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:46:03 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 19:46:03 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 19:46:03 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 19:46:03 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 19:46:03 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 19:46:03 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 19:46:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:46:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:46:03 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 19:46:03 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 19:46:03 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 19:46:03 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 19:46:03 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 19:46:03 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 19:46:04 INFO - Downloading docopt-0.6.1.tar.gz 19:46:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:46:04 INFO - Installing collected packages: blobuploader, requests, docopt 19:46:04 INFO - Running setup.py install for blobuploader 19:46:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:46:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:46:04 INFO - Running setup.py install for requests 19:46:04 INFO - Running setup.py install for docopt 19:46:04 INFO - Successfully installed blobuploader requests docopt 19:46:04 INFO - Cleaning up... 19:46:04 INFO - Return code: 0 19:46:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:46: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')]} 19:46:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46: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')]} 19:46:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:04 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 0x23d31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2745980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2742d00>, '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 0x2743a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2743eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926', '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 19:46:04 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 19:46:04 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 19:46:04 INFO - Using env: {'DISPLAY': ':0', 19:46:04 INFO - 'HOME': '/home/cltbld', 19:46:04 INFO - 'LANG': 'en_US.UTF-8', 19:46:04 INFO - 'LANGUAGE': 'en_US:en', 19:46:04 INFO - 'LOGNAME': 'cltbld', 19:46:04 INFO - 'MAIL': '/var/mail/cltbld', 19:46:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:04 INFO - 'MOZ_NO_REMOTE': '1', 19:46:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:04 INFO - 'NO_EM_RESTART': '1', 19:46:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:04 INFO - 'PWD': '/builds/slave/test', 19:46:04 INFO - 'SHELL': '/bin/bash', 19:46:04 INFO - 'SHLVL': '1', 19:46:04 INFO - 'TERM': 'linux', 19:46:04 INFO - 'TMOUT': '86400', 19:46:04 INFO - 'USER': 'cltbld', 19:46:04 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926', 19:46:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:04 INFO - '_': '/tools/buildbot/bin/python'} 19:46:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:46:05 INFO - Running setup.py (path:/tmp/pip-c984fC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:46:05 INFO - Running setup.py (path:/tmp/pip-hN97hf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:46:05 INFO - Running setup.py (path:/tmp/pip-TvnFxC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:46:05 INFO - Running setup.py (path:/tmp/pip-TqpBZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:46:05 INFO - Running setup.py (path:/tmp/pip-mTcpgY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:46:05 INFO - Running setup.py (path:/tmp/pip-L1PV0I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:46:05 INFO - Running setup.py (path:/tmp/pip-zOZ1Fh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:46:05 INFO - Running setup.py (path:/tmp/pip-HUAZU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:46:05 INFO - Running setup.py (path:/tmp/pip-mG8288-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:46:05 INFO - Running setup.py (path:/tmp/pip-PuRA3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:46:05 INFO - Running setup.py (path:/tmp/pip-ZAimUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:46:05 INFO - Running setup.py (path:/tmp/pip-dmZTYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:46:05 INFO - Running setup.py (path:/tmp/pip-Ws0b6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:46:05 INFO - Running setup.py (path:/tmp/pip-EtSaKk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:46:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:46:06 INFO - Running setup.py (path:/tmp/pip-4g66mU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:46:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:46:06 INFO - Running setup.py (path:/tmp/pip-k7Uhum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:46:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:46:06 INFO - Running setup.py (path:/tmp/pip-CNmL3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:46:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:46:06 INFO - Running setup.py install for manifestparser 19:46:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:46:06 INFO - Running setup.py install for mozcrash 19:46:06 INFO - Running setup.py install for mozdebug 19:46:06 INFO - Running setup.py install for mozdevice 19:46:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:46:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:46:06 INFO - Running setup.py install for mozfile 19:46:06 INFO - Running setup.py install for mozhttpd 19:46:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:46:06 INFO - Running setup.py install for mozinfo 19:46:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:46:06 INFO - Running setup.py install for mozInstall 19:46:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:46:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:46:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:46:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:46:07 INFO - Running setup.py install for mozleak 19:46:07 INFO - Running setup.py install for mozlog 19:46:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:46:07 INFO - Running setup.py install for moznetwork 19:46:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:46:07 INFO - Running setup.py install for mozprocess 19:46:07 INFO - Running setup.py install for mozprofile 19:46:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:46:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:46:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:46:07 INFO - Running setup.py install for mozrunner 19:46:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:46:07 INFO - Running setup.py install for mozscreenshot 19:46:07 INFO - Running setup.py install for moztest 19:46:07 INFO - Running setup.py install for mozversion 19:46:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:46:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:46:08 INFO - Cleaning up... 19:46:08 INFO - Return code: 0 19:46:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:46:08 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')]} 19:46:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:08 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')]} 19:46:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:08 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 0x23d31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2745980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2742d00>, '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 0x2743a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2743eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926', '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 19:46:08 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 19:46:08 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 19:46:08 INFO - Using env: {'DISPLAY': ':0', 19:46:08 INFO - 'HOME': '/home/cltbld', 19:46:08 INFO - 'LANG': 'en_US.UTF-8', 19:46:08 INFO - 'LANGUAGE': 'en_US:en', 19:46:08 INFO - 'LOGNAME': 'cltbld', 19:46:08 INFO - 'MAIL': '/var/mail/cltbld', 19:46:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:08 INFO - 'MOZ_NO_REMOTE': '1', 19:46:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:08 INFO - 'NO_EM_RESTART': '1', 19:46:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:08 INFO - 'PWD': '/builds/slave/test', 19:46:08 INFO - 'SHELL': '/bin/bash', 19:46:08 INFO - 'SHLVL': '1', 19:46:08 INFO - 'TERM': 'linux', 19:46:08 INFO - 'TMOUT': '86400', 19:46:08 INFO - 'USER': 'cltbld', 19:46:08 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926', 19:46:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:08 INFO - '_': '/tools/buildbot/bin/python'} 19:46:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:46:08 INFO - Running setup.py (path:/tmp/pip-jv9vvU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:46:08 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)) 19:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:46:08 INFO - Running setup.py (path:/tmp/pip-W1XR8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:46:08 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)) 19:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:46:08 INFO - Running setup.py (path:/tmp/pip-hYRuQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:46:08 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)) 19:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:46:08 INFO - Running setup.py (path:/tmp/pip-v9gY6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:46:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:46:08 INFO - Running setup.py (path:/tmp/pip-2sfQ5v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:46:08 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)) 19:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:46:08 INFO - Running setup.py (path:/tmp/pip-MieBBV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:46:08 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)) 19:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:46:08 INFO - Running setup.py (path:/tmp/pip-dFlHxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:46:08 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)) 19:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:46:08 INFO - Running setup.py (path:/tmp/pip-MyNCFP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:46:08 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)) 19:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:46:08 INFO - Running setup.py (path:/tmp/pip-L0hOqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:46:08 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)) 19:46:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:46:08 INFO - Running setup.py (path:/tmp/pip-Pg8cSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:46:09 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)) 19:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:46:09 INFO - Running setup.py (path:/tmp/pip-FIPVgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:46:09 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)) 19:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:46:09 INFO - Running setup.py (path:/tmp/pip-fvQyZd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:46:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 19:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:46:09 INFO - Running setup.py (path:/tmp/pip-KMHsGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:46:09 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)) 19:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:46:09 INFO - Running setup.py (path:/tmp/pip-0oZlfk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:46:09 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)) 19:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:46:09 INFO - Running setup.py (path:/tmp/pip-kbQaQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:46:09 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)) 19:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:46:09 INFO - Running setup.py (path:/tmp/pip-AzOYvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:46:09 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)) 19:46:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:46:09 INFO - Running setup.py (path:/tmp/pip-N5Ret9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:46:09 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)) 19:46:09 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)) 19:46:09 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)) 19:46:09 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)) 19:46:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:46:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:46:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:46:09 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 19:46:09 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 19:46:09 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 19:46:09 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 19:46:09 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 19:46:09 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 19:46:11 INFO - Downloading blessings-1.6.tar.gz 19:46:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:46:11 INFO - Installing collected packages: blessings 19:46:11 INFO - Running setup.py install for blessings 19:46:11 INFO - Successfully installed blessings 19:46:11 INFO - Cleaning up... 19:46:11 INFO - Return code: 0 19:46:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:46:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:46:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:46:11 INFO - Reading from file tmpfile_stdout 19:46:11 INFO - Current package versions: 19:46:11 INFO - argparse == 1.2.1 19:46:11 INFO - blessings == 1.6 19:46:11 INFO - blobuploader == 1.2.4 19:46:11 INFO - docopt == 0.6.1 19:46:11 INFO - functools32 == 3.2.3-2 19:46:11 INFO - jsonschema == 2.5.1 19:46:11 INFO - manifestparser == 1.1 19:46:11 INFO - mozInstall == 1.12 19:46:11 INFO - mozcrash == 1.0 19:46:11 INFO - mozdebug == 0.1 19:46:11 INFO - mozdevice == 0.49 19:46:11 INFO - mozfile == 1.2 19:46:11 INFO - mozhttpd == 0.7 19:46:11 INFO - mozinfo == 0.9 19:46:11 INFO - mozleak == 0.1 19:46:11 INFO - mozlog == 3.4 19:46:11 INFO - moznetwork == 0.27 19:46:11 INFO - mozprocess == 0.24 19:46:11 INFO - mozprofile == 0.28 19:46:11 INFO - mozrunner == 6.13 19:46:11 INFO - mozscreenshot == 0.1 19:46:11 INFO - mozsystemmonitor == 0.3 19:46:11 INFO - moztest == 0.8 19:46:11 INFO - mozversion == 1.4 19:46:11 INFO - psutil == 3.1.1 19:46:11 INFO - requests == 1.2.3 19:46:11 INFO - wsgiref == 0.1.2 19:46:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:46:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:46:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:12 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 0x23d31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2745980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2742d00>, '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 0x2743a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2743eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926', '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 19:46:12 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 19:46:12 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 19:46:12 INFO - Using env: {'DISPLAY': ':0', 19:46:12 INFO - 'HOME': '/home/cltbld', 19:46:12 INFO - 'LANG': 'en_US.UTF-8', 19:46:12 INFO - 'LANGUAGE': 'en_US:en', 19:46:12 INFO - 'LOGNAME': 'cltbld', 19:46:12 INFO - 'MAIL': '/var/mail/cltbld', 19:46:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:12 INFO - 'MOZ_NO_REMOTE': '1', 19:46:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:12 INFO - 'NO_EM_RESTART': '1', 19:46:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:12 INFO - 'PWD': '/builds/slave/test', 19:46:12 INFO - 'SHELL': '/bin/bash', 19:46:12 INFO - 'SHLVL': '1', 19:46:12 INFO - 'TERM': 'linux', 19:46:12 INFO - 'TMOUT': '86400', 19:46:12 INFO - 'USER': 'cltbld', 19:46:12 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926', 19:46:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:12 INFO - '_': '/tools/buildbot/bin/python'} 19:46:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:12 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)) 19:46:12 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)) 19:46:12 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)) 19:46:12 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)) 19:46:12 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)) 19:46:12 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)) 19:46:12 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)) 19:46:12 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)) 19:46:12 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)) 19:46:12 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)) 19:46:12 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)) 19:46:12 INFO - Cleaning up... 19:46:12 INFO - Return code: 0 19:46:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:46:12 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')]} 19:46:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:46:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:12 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')]} 19:46:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:46:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:46:12 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 0x23d31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25a0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2745980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2742d00>, '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 0x2743a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2743eb0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926', '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 19:46:12 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 19:46:12 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 19:46:12 INFO - Using env: {'DISPLAY': ':0', 19:46:12 INFO - 'HOME': '/home/cltbld', 19:46:12 INFO - 'LANG': 'en_US.UTF-8', 19:46:12 INFO - 'LANGUAGE': 'en_US:en', 19:46:12 INFO - 'LOGNAME': 'cltbld', 19:46:12 INFO - 'MAIL': '/var/mail/cltbld', 19:46:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:12 INFO - 'MOZ_NO_REMOTE': '1', 19:46:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:12 INFO - 'NO_EM_RESTART': '1', 19:46:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:12 INFO - 'PWD': '/builds/slave/test', 19:46:12 INFO - 'SHELL': '/bin/bash', 19:46:12 INFO - 'SHLVL': '1', 19:46:12 INFO - 'TERM': 'linux', 19:46:12 INFO - 'TMOUT': '86400', 19:46:12 INFO - 'USER': 'cltbld', 19:46:12 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926', 19:46:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:12 INFO - '_': '/tools/buildbot/bin/python'} 19:46:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:46:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:46:12 INFO - Cleaning up... 19:46:12 INFO - Return code: 0 19:46:12 INFO - Running post-action listener: _resource_record_post_action 19:46:12 INFO - Running post-action listener: _start_resource_monitoring 19:46:12 INFO - Starting resource monitoring. 19:46:12 INFO - [mozharness: 2017-02-06 03:46:12.487041Z] Finished create-virtualenv step (success) 19:46:12 INFO - [mozharness: 2017-02-06 03:46:12.487480Z] Running install step. 19:46:12 INFO - Running pre-action listener: _resource_record_pre_action 19:46:12 INFO - Running main action method: install 19:46:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:46:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:46:12 INFO - Reading from file tmpfile_stdout 19:46:12 INFO - Detecting whether we're running mozinstall >=1.0... 19:46:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:46:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:46:12 INFO - Reading from file tmpfile_stdout 19:46:12 INFO - Output received: 19:46:12 INFO - Usage: mozinstall [options] installer 19:46:12 INFO - Options: 19:46:12 INFO - -h, --help show this help message and exit 19:46:12 INFO - -d DEST, --destination=DEST 19:46:12 INFO - Directory to install application into. [default: 19:46:12 INFO - "/builds/slave/test"] 19:46:12 INFO - --app=APP Application being installed. [default: firefox] 19:46:12 INFO - mkdir: /builds/slave/test/build/application 19:46:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:46:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:46:29 INFO - Reading from file tmpfile_stdout 19:46:29 INFO - Output received: 19:46:29 INFO - /builds/slave/test/build/application/firefox/firefox 19:46:29 INFO - Running post-action listener: _resource_record_post_action 19:46:29 INFO - [mozharness: 2017-02-06 03:46:29.253327Z] Finished install step (success) 19:46:29 INFO - [mozharness: 2017-02-06 03:46:29.253670Z] Running run-tests step. 19:46:29 INFO - Running pre-action listener: _resource_record_pre_action 19:46:29 INFO - Running main action method: run_tests 19:46:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:46:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:46:29 INFO - Python 2.7.3 19:46:29 INFO - Return code: 0 19:46:29 INFO - grabbing minidump binary from tooltool 19:46:29 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')]} 19:46:29 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 0x2742d00>, '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 0x2743a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2743eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:46:29 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 19:46:29 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 19:46:29 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 19:46:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:46:29 INFO - Return code: 0 19:46:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:46:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:46:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:46:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:46:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:46:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:46:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-029 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:46:29 INFO - Using env: {'DISPLAY': ':0', 19:46:29 INFO - 'HOME': '/home/cltbld', 19:46:29 INFO - 'LANG': 'en_US.UTF-8', 19:46:29 INFO - 'LANGUAGE': 'en_US:en', 19:46:29 INFO - 'LOGNAME': 'cltbld', 19:46:29 INFO - 'MAIL': '/var/mail/cltbld', 19:46:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:46:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:46:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:46:29 INFO - 'MOZ_NO_REMOTE': '1', 19:46:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:46:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:46:29 INFO - 'NO_EM_RESTART': '1', 19:46:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:46:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:46:29 INFO - 'PWD': '/builds/slave/test', 19:46:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:46:29 INFO - 'SHELL': '/bin/bash', 19:46:29 INFO - 'SHLVL': '1', 19:46:29 INFO - 'TERM': 'linux', 19:46:29 INFO - 'TMOUT': '86400', 19:46:29 INFO - 'USER': 'cltbld', 19:46:29 INFO - 'XDG_SESSION_COOKIE': 'ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926', 19:46:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:46:29 INFO - '_': '/tools/buildbot/bin/python'} 19:46:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-029', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:46:29 INFO - mozversion application_buildid: 20170206024928 19:46:29 INFO - mozversion application_changeset: 2085bd699dbdf9ec22bf98adcecb4b8ffd099bed 19:46:29 INFO - mozversion application_display_name: FirefoxDeveloperEdition 19:46:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:46:29 INFO - mozversion application_name: Firefox 19:46:29 INFO - mozversion application_remotingname: firefox-dev 19:46:29 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:46:29 INFO - mozversion application_vendor: Mozilla 19:46:29 INFO - mozversion application_version: 53.0a2 19:46:29 INFO - mozversion platform_buildid: 20170206024928 19:46:29 INFO - mozversion platform_changeset: 2085bd699dbdf9ec22bf98adcecb4b8ffd099bed 19:46:29 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 19:46:29 INFO - mozversion platform_version: 53.0a2 19:46:29 INFO - using testdate: 1486352789 19:46:29 INFO - actual date: 1486352789 19:46:29 INFO - starting webserver on 'localhost:53839' 19:46:29 INFO - SUITE-START | Running 2 tests 19:46:29 INFO - TEST-START | dromaeo_css 19:46:29 INFO - operating with platform_type : linux_ 19:46:29 INFO - Initialising browser for dromaeo_css test... 19:46:29 INFO - TEST-INFO | started process 26530 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv70rVI/profile http://localhost:53839/getInfo.html) 19:46:34 INFO - PROCESS | 26530 | __metrics Screen width/height:1600/1200 19:46:34 INFO - PROCESS | 26530 | colorDepth:24 19:46:34 INFO - PROCESS | 26530 | Browser inner width/height: 1024/697 19:46:34 INFO - PROCESS | 26530 | __metrics 19:46:34 INFO - PROCESS | 26530 | 1486352794851 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmpv70rVI/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpv70rVI/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpv70rVI/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpv70rVI/profile/extensions/talos-powers@TalosPowersService.js:55:9 19:46:34 ERROR - PROCESS | 26530 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 19:46:36 INFO - TEST-INFO | 26530: exit 0 19:46:36 INFO - Browser initialized. 19:46:36 INFO - Running cycle 1/1 for dromaeo_css test... 19:46:36 INFO - TEST-INFO | started process 26659 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpv70rVI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:46:47 INFO - PROCESS | 26659 | RSS: Main: 144379904 19:46:47 INFO - PROCESS | 26659 | 19:49:46 INFO - PROCESS | 26659 | Cycle 1(1): loaded http://localhost:53839/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53839/tests/dromaeo/cssquery-ext.html) 19:49:47 INFO - PROCESS | 26659 | RSS: Main: 152449024 19:49:47 INFO - PROCESS | 26659 | 19:51:36 INFO - PROCESS | 26659 | ************************* 19:51:36 INFO - PROCESS | 26659 | A coding exception was thrown and uncaught in a Task. 19:51:36 INFO - PROCESS | 26659 | 19:51:36 ERROR - PROCESS | 26659 | Full message: TypeError: NetworkError when attempting to fetch resource. 19:51:36 INFO - PROCESS | 26659 | Full stack: 19:51:36 INFO - PROCESS | 26659 | ************************* 19:52:50 INFO - PROCESS | 26659 | Cycle 1(1): loaded http://localhost:53839/tests/dromaeo/cssquery-ext.html (next: http://localhost:53839/tests/dromaeo/cssquery-jquery.html) 19:52:50 INFO - PROCESS | 26659 | RSS: Main: 149307392 19:52:50 INFO - PROCESS | 26659 | 19:55:52 INFO - PROCESS | 26659 | Cycle 1(1): loaded http://localhost:53839/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53839/tests/dromaeo/cssquery-mootools.html) 19:55:53 INFO - PROCESS | 26659 | RSS: Main: 152514560 19:55:53 INFO - PROCESS | 26659 | 19:58:54 INFO - PROCESS | 26659 | Cycle 1(1): loaded http://localhost:53839/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53839/tests/dromaeo/cssquery-prototype.html) 19:58:55 INFO - PROCESS | 26659 | RSS: Main: 151674880 19:58:55 INFO - PROCESS | 26659 | 20:01:57 INFO - PROCESS | 26659 | Cycle 1(1): loaded http://localhost:53839/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53839/tests/dromaeo/cssquery-yui.html) 20:01:58 INFO - PROCESS | 26659 | RSS: Main: 154894336 20:01:58 INFO - PROCESS | 26659 | 20:05:00 INFO - PROCESS | 26659 | Cycle 1(1): loaded http://localhost:53839/tests/dromaeo/cssquery-yui.html (next: http://localhost:53839/tests/dromaeo/cssquery-dojo.html) 20:05:00 INFO - PROCESS | 26659 | RSS: Main: 153890816 20:05:00 INFO - PROCESS | 26659 | 20:05:00 INFO - PROCESS | 26659 | __start_tp_report 20:05:00 INFO - PROCESS | 26659 | _x_x_mozilla_page_load 20:05:00 INFO - PROCESS | 26659 | _x_x_mozilla_page_load_details 20:05:00 INFO - PROCESS | 26659 | |i|pagename|runs| 20:05:00 INFO - PROCESS | 26659 | |0;dojo.html;3283.8358082095892;3304.90085297441;3314.514842004468;3320.5185248139037;3338.732901367891;5589.74846131924;5599.832005039845;5619.831405057855;5637.830865074044;5643.689597072164;5585.469380408855;5596.832095037145;5655.519280861132;5662.971685141579;5665.433456654332;4970.850874473772;5044.520770526794;5051.848444546669;5090.541851233388;5138.845834624948;5103.183490641498;5129.333186685725;5140.306058682087;5152.845414637548;5154.793808247666;4924.876878078041;4932.728699921503;5122.538971492565;5136.512031357015;5151.021305951876;5036.571891389236;5058.165402708549;5058.620603454738;5093.439721630618;5146.150885103953;4981.078500477423;5062.645614806965;5067.062593420229;5067.417247016603;5085.389753229599;5463.7814487420455;5595.776168953237;5596;5673.886522269531;5695.288088988877;5908.852278693067;5931.436513531251;5933.821985340447;5968.37332080134;6061.302950160743;6036.396360363972;6047.546434017422;6056.636601803906;6070.969645151746;6082.148499210114;5673.886522269531;5677.40387259336;5680.460356266148;5680.801171959003;5681.375048744635;5909.645421274738;5984.611000284967;6028.306744724325;6071.332153463116;6092.147099406086;5874.853128671817;5927.3776253493625;5936.317323507766;5944.970275148597;5969.224000879858;5971.641701497837;6032.426919442646;6039.184710064173;6040.335563088057;6043.969780151071;5777.104548794943;5857.912131318034;5933.406659334032;5993.790217342372;6017;6049.667268300285;6054.848628784228;6056.515478761688;6066.939330606638;6104.938950610526;4662.300654901792;4695.178343789823;4705.458872229738;4707.411573553306;4729.4797572267025;3988.062805240766;3997.6601988831276;4080.469538959916;4083.7549747015273;4125.401816736557;5852.063669812809;5873.765049397976;5922.407759224043;5924.9703751480965;5943.049112142123;6044.24446944132;6105.511559075263;6113.29697084841;6116.113163591343;6122.571420000646;5686.601937864392;5898.64608123514;5902.76388944446;5908.852278692981;6047.213862197887;5216.217567364925;5223.738813059332;5233.2935053768015;5233.816816411408;5236.266922630834;6293.653849038347;6326;6373.6175829450385;6393.968030159819;6414.358564143548;5885.852853678693;5943.346231914573;5961.314448838439;5981.52147828164;5997.970010149921;6189.164462797465;6235.781747638811;6239.220097487814;6244.094606281973;6283.74865005413;5906.40935906406;5958.821235362946;5979.880402392015;5998.25021872266;6021.819345419644;5823.7379317929945;5867.178594996619;5929.229200204119;5946.375630558729;6046.667433291035;5861.296644402699;5864.853378665567;5873.177755114202;5894.174815525916;5922.289325280994;5813.709314534171;5823.505002074871;5848.970755146197;5868.3251426086545;5870.618409803349;5774.711264436845;5820.912686309624;5822.475977162076;5838.036723940502;5843.386444423444;5687.146927960839;5934.762609495572;5975.223220981418;5976.641401515923;6015.849603759766;5820.039693450533;5821.155932389865;5845.152452894392;5846.239988801429;5870.207521984477 20:05:00 INFO - PROCESS | 26659 | |1;ext.html;581.6103210848731;609.4423602403799;639.945604623607;657.6087228099279;695.4888157204457;43194.78402607986;47653.52346476534;47675.28487072692;47701.52298477014;47868.76065619667;48560.271595926;49175;49338.75330623342;49363.50636493634;49393.259101113515;9276.628934842598;9448.57481413338;9477.573509192103;10641.893581064167;10972.396518191495;11024.5038973246;11092.279001864894;11102.833457498144;11118.499667514981;11142.164337674667;11159.051480624157;11196.104311655088;11200.719982000475;11203.551857925673;11210.383428911407;11041.613543525938;11091.667249982473;11124;11148.777024459465;11156.16328775345;11034.448277586089;11105.72235694106;11114.777704445865;11119.610813621484;11129.610463633815;42121;42176.57823421788;42233.366499502226;42554.148917021485;42698.359524607156;4262.360645903108;4520.457545094577;4555.111753208126;4667.836625718118;4708.128996135726;32253.35493290121;32324;32692.836535817405;33158.17104572381;33398.33203335944;4338.848140315105;4347.37348250889;4392.143532011259;4403.4495688039;4492.61812745917;354208;354728;356157;356889;357670;61182;61553.69223153855;61632.383676162666;61706.69146654238;61771.38228617746;62956.68521657454;62963.685181574714;63274.367256327765;63537.68231158907;63849.36150638527;18490.445286641152;18751.156197971122;18846.151923163492;18865.056747162587;18890.3388381406;13423.463061477432;13429.932850335881;14258.572242832732;14265.714685706227;14363.497277595234;19269.132889020028;19652.70520942187;19841.20635174577;19855.205791768167;20015.899920500306;7757.53454792703;7768.096816280047;7799.181085986003;7836.647350869224;7909.7231596893835;932.6129656192604;941.8916824565125;948.4119845695575;963.3064193780467;968.864358989742;33408.665913340556;33579;33642.663573363956;33892.13516672044;34225.828870855985;1060.3955745225148;1170.7073231692077;1197.5209916033657;1198.1313547677864;1209.4738788626976;17353.479395618153;17612.471625851245;17747.645047099242;17782.377616783608;17844.286228550973;514756;515885;519055;523370;523557;62381.68809156016;62516;62830.68584657047;63059.05411418832;63182;1518.2788175616715;1554.8367421420814;1565.6790357976815;1567.8902476826513;1583.073901767456;30161.547576785928;31173.844130780108;31296.687033129376;31309.8434507826;31702.207444813143;52403;55640.44359556514;57880.71059644675;58062.4193758057;65311.346886530526;548519;553719;554682;556137;556157;29334.26664333409;29378.412431750818;29425.705742942297;31904.84047579747;43600;47435.76282118567;47705.761471192425;47717.52282477131;47964;49517.752411237714;40366.1926761469;40714;41316.586834131274;41875.58124418839;42103.36844947267;39684.801575991936;40284;41257.58742412538;41322;41809;39995;40971.79514102411;41126.383104254055;41361;41460;34294;35387.839424520476;35945;35955.46066809052;36086.819565902006;25963.74036259613;26412.171009885853;26929.326766830985;27071.45857082808;27206.455870882866 20:05:00 INFO - PROCESS | 26659 | |2;jquery.html;442.52207615774967;446.8034065011395;448.74870072759245;453.21819860740226;459.0932907507672;20554.075066622;20824.99999999998;21153.471163220926;22216.555668886613;22264.99807508662;22433.66349504759;23132.30603081906;23202.535949281006;23339.416514587145;23496.88251558744;6091.908621370672;6236.750529978795;6271.937280627204;6332.905006424908;6346.01636746305;6337.746490140389;6527.086207930894;6532.902006469907;6539.967300163493;6558.409743123118;6377.968110159442;6464.191976003;6486.805395838132;6490.318516555764;6565.343465653445;6330.620162790201;6500.934990650104;6504.121943537609;6580.835479113012;6595.373439523214;6335.081413195107;6374.107624932467;6381.68091595423;6387.393197646216;6389.265234498046;15763.605909852231;18892.811071889242;26580.86709566459;27298.317542061606;27309.863450682817;2793.064323451646;2835.957460638092;2888.321244507539;2905.8982935597364;2917.3144311086876;10773.78452430947;10945.343279403261;11684.474198660995;12389.876101239053;15408.922955385264;2035.592881423721;2062.6287268291703;2074.5643414882893;2077.356019633918;2081.573277478113;100711.49644251732;102110;102249.4887525565;102425.83297576189;104587.81648734042;12469.563565275172;12759.170653907466;12845.229286242855;12883.935580322039;13061;18527.07364631763;18544.443666690022;18556.257749689863;18626.81373186251;18648;9176.265898728087;9468.763280918032;9504.619815207452;9621.807563848824;9649.951750241204;8969.775755606162;9014.323925705598;9025.736396904438;9041.864372034424;9175.08249175077;5363.115086010765;5423.918641220384;5448.591355648342;5471.097268950579;5495.313085864267;2191.41927389242;2191.8684878907316;2205.790449907256;2260.8982595783227;2282.6005449046684;945.1210374351919;959.5681943125481;964.1997142371955;966.6423423333271;977.9364341317792;20306.796932030786;21152.259670911444;21480.892595536923;21575.35273941784;21575.67636485454;969.1084202533686;975.8145952269189;978.5908292059554;980.9460479673686;992.3946392700446;11456.026237769716;11784;11844;11873.881261187451;11976.161668683282;639036;647395;661004;667158;697061;114187.42906285582;114405.4279728596;114792;115252;118968.40515797366;1080.2978064258139;1114.899659030691;1130.717320669849;1137.3517095255625;1139.9772004559863;17954.820451795837;18481.075946202905;18534.629307414045;18548.814511854707;18599.256029758657;47110;47273;47296.76351618358;48572.514274856796;49684.751576241884;66708.33229169309;66804;66865.66567167133;67505;67724.3227567718;8776.912230877864;8953.597088130919;8954.417962832395;9160.038195989326;9345;8960.731178064669;12598.118131730691;12653.177543459646;12727.80908286358;13223.404946777226;11269.91424630723;11421.543138274375;11428.599999000327;11652.475638596114;11734.178607497393;10455.529501172314;10783.946080269863;10801.513931873242;11033.117350611772;11206.551737930391;11132.443377830914;11767.293962362286;11843.467043983213;11884;11967.222130561486;8740.213380795505;8873.157050080232;8882.822343552964;8951.373403861668;8981.595828187877;9682.56428460707;10915.072218861169;10936.671899842699;10942.343459392461;11214.271072380268 20:05:00 INFO - PROCESS | 26659 | |3;mootools.html;1497.2438918346247;1514.5759187427518;1514.621344663834;1522.132384540812;1527.2898102382394;8129.55287459191;8401.327893768499;8666.090060543638;9177.219936305413;9192.402493837904;8694.21752042316;8949.328800339968;8955.104489551042;9203.447793132416;9203.815923681523;2484.5030993801265;2518.508890766301;2537.8223524353302;2538.987305063472;2543.2878793937634;2450.0567281596623;2514.660520829683;2515.7987361011164;2518.3704073981503;2521.407469244726;2422.2612103308484;2437.5856104462196;2450.105711415338;2450.534398464295;2455.1407007547305;2361.3978435498925;2363.988180059106;2367.2543148908126;2383.082513232418;2385.940351491209;2398.040783686522;2399.4841109161616;2416.685830841997;2421.0436877433317;2457;8824.955875220647;8867.556622168866;8885.155910188521;8894.510801905893;8925.152110549487;5482.533984611313;5622.072358060915;5624.3531993820825;5624.831255062355;5637;3364.142143753352;3456.5333679953137;3504.8422820972864;3508.4035713928693;3541.645835416438;1403.9789403158961;1423.9715205695932;1443.0620096937075;1449.0581122270503;1489.4116823854624;11414.086873050219;11516.712082197928;11688.590899318484;11963.760724785543;11968.640940771791;4612.30815377696;4633.166030114544;4746.905061898743;4750.14497390473;4791.041791641685;9783;9885.110340069285;9892.60429582823;9907.950460247652;9931.602735890483;5604.663720176803;5622.156676498476;5626.409227031185;5637.802676906289;5649.0396632572565;5060.2156665716875;5198.882240318349;5254.947450525522;5287.788488460418;5310.415854256029;4052.858149964737;4072.572379900127;4099.8975025624;4122.031322639177;4155.563665815106;1159.2175281684829;1165.906727461801;1166.393475392791;1176.72346998457;1188.4711303469874;972.4116909269932;1005.7686732051669;1013.2755080117752;1014.4471263161595;1025.2157099818644;6097.512199024068;6113.205283313141;6196.628202307876;6223;6225.968870155621;636.7612145445459;651.205529254309;651.9185101862267;665.7203974330793;667.366002297819;3854.5952674969285;3875.2249550090096;3910.530736311661;3955.268275369066;3975.2447035063824;10540.525676344583;10855.891441085647;10908.472813806073;10924.180686448548;10939.343639381663;10783.46082695862;10806.94596527028;10830.891691083147;10837.512311945982;10839.458027098772;8144.633491492897;8338.124496927856;8416.705415310435;8585.227329540496;8586.184312490303;6068.453839154321;6320.683965801783;6332.208473940757;6346.111544383698;6365.490760739037;9591.232701384011;9748.85376719364;9872.45701486425;9887.555060022172;10059;10100.898991009995;10101.545430455793;10152.54313555877;10181.643642472478;10202.489875506344;7142.5000249982;7936.047674279123;7947.403944704055;7981.321587665114;8110.918890811016;8750.781230469289;8786;8794.120587941155;8817.867731983897;8825.470471771458;7654.15804261542;7704.576248306397;7706.537607743553;7724.150343462327;7750.10873749526;7405.668857240024;7443.3673137781725;7467.141278752796;7543.358814500829;7629.618519074135;6782.762603308861;6795.490338224554;6838.076859623887;6875.48433867452;6887.758928437481;5265.262863199232;5305.310309659874;5387.461253874581;5393.946060539502;5397.676139431646;5419.3225846769155;5445.918311225256;5479.068558345011;5522.751476183662;5538.723063846711 20:05:00 INFO - PROCESS | 26659 | |4;prototype.html;417.58867515497235;418.2972606021882;418.8492142828581;427.9786010699464;430.9138172365526;5341.839744807662;5511.311086114236;5514.779408823642;5570.637908535942;5643.774249030039;5323.148296272597;5403.243545903577;5492.80775172869;5507;5514.393416724157;4186.874393768192;4304.827806887721;4308.190559964823;4376.934345984812;4384.364267181257;4284.528701842794;4301.2902871026245;4308.0737641407095;4308.362822127587;4317.69776115672;4266.807993640294;4296.355546667994;4303.396445150685;4320.697551171419;4373.016071383945;4191.365367506675;4294.549072347421;4348.412964249817;4354.303311470149;4359.629431498311;3810.580836108026;3814.6757525610356;3817.1983883384523;3818.8281527331337;3855.6529912307747;5436.565074794007;5438.456154384569;5439.619226654136;5472.5621950243885;5490.231367608538;4837.685550439211;5001.574866136383;5016.946441247343;5040.9918016396505;5055.9241611375855;5740.138979153118;5791.971040144815;5797.826065218008;5822.107814960155;5826.242588463472;4275.401443797839;4282.721623094489;4291.570842915715;4298.46269216348;4304.354346847967;5828.6502809831545;5993.011153159679;6057.30341010785;6095.207623009025;6137.877242455171;4292.720973136736;4298.699091063658;4341.088371442032;4350.1294443389015;4358.607725304674;4414.205443020287;4418.359337895987;4419.160359531678;4421.955780442155;4432.977835110803;4834.371531700856;4942.233953737176;4954.355933728664;4964.925526117111;4973.875653108629;5738.282714660668;5795.710214489259;5796.88406231873;5802.33273173582;5808.157817116579;1462.627030107316;1466.142306750563;1470.6176394137387;1475.9335829887682;1485.3883536363167;970.1075010989906;1005.416858222244;1022.1311884897777;1023.6232267600066;1043.4939054558533;5487.807926722546;5498.422665620133;5509.146082357241;5523.364813046551;5535.003699334158;5750.971245143747;5761.452661997104;5762.74067666956;5773.451522105393;5795.768169273182;5458.45415458459;5526.4197259288;5547.472990065938;5577.24316840194;5624.3813180550105;3031.711522602885;3089.2276930767307;3089.6096756459233;3097.566340712257;3102.720755132049;5855.707214639251;5992.8801423972145;6042.0967395270345;6043.335233124353;6054.485368743618;5812.680302583399;5856.355800861902;5862.508433915569;5899.351071382144;5909.172715819789;5977.551683623746;6001.159837622737;6006.609570377911;6020.591763294629;6027.21646185993;5614.606977511535;5620.189905047477;5703.201551782837;5733.627314224562;5748.971255143698;5631.902453650558;5649.096144616841;5650.717464126859;5657.5473962082115;5677.460641239076;5947.762089516371;5986.491148252448;6121.969390153021;6137.815865524041;6178.938210617836;4263.573642635712;4324.56754324565;4329.264025115801;4334.393184954046;4345.717528360647;5765.365809760839;5969.791057313147;5984.371640977634;5989.5507836913275;6045.153678485103;5774.797882074107;5788.681622510634;5795.420457954171;5812.546863284179;5813.186153938536;5728.770849165987;5806.912896306474;5810.273715785527;5811.854703632443;5828.04760405269;5570.220169176399;5661.631993920382;5714.942850571441;5778.595498315078;5786.33457152416;5786.508146807569;5790.276215473066;5827.388124246893;5874.823755287348;5907.695998560651;5565.248691426606;5739.426057394227;5762.415335782694;5783.392743761844;5792.333881603669 20:05:00 INFO - PROCESS | 26659 | |5;yui.html;785.6739453126953;805.8468890910726;829.4774292195916;924.6347692661399;938.9014153513881;16548.420805271817;17643.47069587913;17874.374396896095;17991.100444977732;17999.91000045001;16639.584010399747;16732.83267167328;17302.56743581408;17404.738928916075;17956.461306160803;814.5601375257354;825.63671984327;842.8735689646571;843.4306842881061;844.6494704697543;824.9670013199465;829.2246749289403;830.9169083091703;830.9376796740269;831.1107115386538;869.9391042627019;872.1888643561485;872.5855218771096;876.1632640827994;876.8334016536869;872.4590753732695;873.3449912565576;874.45783614159;875.1598465473154;875.7197696737047;639.5682914033056;640.9775657852;642.6272761798145;643.9935600644027;644.3202421445374;16066.75899861503;16178.35286588535;16201.513954581382;17840.107994600217;17995.010274434902;16030.919845400815;16288.918555407146;16335.101569413677;16343;16500.25748841293;13418.329083545783;13488.258145801978;13578.185308881499;13747.38136783847;13825.446982120704;3986.242613903349;3987.1626958338784;3988.8603898863403;4006.859759908389;4023.7988100595144;79261.10180661346;79462.20537794664;80179;80647.19352806456;81053;12444.564440244549;12530;12607.810882836582;12641.494340226473;12779.36103194855;23544.64683029756;23662;23663.645045324334;23669.408264793517;23737;8160.469569478084;8265.868358761112;8299.29455996235;8307.83384332322;8524.36067294943;5065.493450654905;5077.669951453144;5089.134847076006;5108.259302401206;5110.66780659256;3681.7422780405113;3732.346839303111;3738.1962877981364;3792.6965842732516;3795.203007368428;563.1383982506771;568.3634329550929;571.7027145884117;575.2406822993692;578.9594728369058;871.1288711288711;883.4301875290402;893.5041052215953;896.3814967672286;898.7124120281578;11090.22368434218;11413.714657133472;11443.656690299138;11584.652460426201;11656.592019279455;838.5094719588986;842.8675303090955;848.7708318753902;872.991270087291;878.0911756332293;5210.53105220532;5456.890862182813;5497.147942068986;5533.225348451139;5538.556915446755;80959.5952020248;82161;82257.17742822615;84011.5799420999;86902;68341.65829170823;69978;71807;72636.27363726294;73505.26494734985;63545.36454635487;64298.67850660717;64429.355706443275;64470.35529644737;65573.67213163999;11552.364619945984;12043.277403355476;12170.939145304217;12446.688832779253;12448.937755311528;36589.634103659686;39562;40928.79535602303;41420;42163.578364215966;54607.453925460235;54679;56220.43779562152;56339.43660563342;56997.715011424676;14164.220967846868;14190.787138192729;14199;14206.928965355108;14418.927905360406;16102.516924492284;16257.59356016109;16408.753868692216;16643.3342666292;16831.070000644286;15517.922410387875;15594.37622495133;15944.202789860228;16162.67674646524;16332.183390830649;15074.472393466176;15192.240387980777;15289.847101528841;15677.451289204822;15961.680766384376;15200.239988000776;15249.161833321532;15349.386024559339;15372.615684607526;15582.298796554409;12533.623991280276;13304.334783260992;13409.195448272745;13409.463621455032;13524.391402387113;12058.15592908488;12098.274103553815;12262.632121036384;12301.384930753606;12411.62765117048 20:05:00 INFO - PROCESS | 26659 | __end_tp_report 20:05:00 INFO - PROCESS | 26659 | __start_cc_report 20:05:00 INFO - PROCESS | 26659 | _x_x_mozilla_cycle_collect,320 20:05:00 INFO - PROCESS | 26659 | __end_cc_report 20:05:00 INFO - PROCESS | 26659 | __startTimestamp1486353900966__endTimestamp 20:05:00 INFO - PROCESS | 26659 | 20:05:00 INFO - PROCESS | 26659 | ------- Summary: start ------- 20:05:00 INFO - PROCESS | 26659 | Number of tests: 6 20:05:00 INFO - PROCESS | 26659 | 20:05:00 INFO - PROCESS | 26659 | [#0] dojo.html Cycles:165 Average:5601.04 Median:5857.91 stddev:636.58 (10.9%) stddev-sans-first:612.02 20:05:00 INFO - PROCESS | 26659 | Values: 3283.8 3304.9 3314.5 3320.5 3338.7 5589.7 5599.8 5619.8 5637.8 5643.7 5585.5 5596.8 5655.5 5663.0 5665.4 4970.9 5044.5 5051.8 5090.5 5138.8 5103.2 5129.3 5140.3 5152.8 5154.8 4924.9 4932.7 5122.5 5136.5 5151.0 5036.6 5058.2 5058.6 5093.4 5146.2 4981.1 5062.6 5067.1 5067.4 5085.4 5463.8 5595.8 5596.0 5673.9 5695.3 5908.9 5931.4 5933.8 5968.4 6061.3 6036.4 6047.5 6056.6 6071.0 6082.1 5673.9 5677.4 5680.5 5680.8 5681.4 5909.6 5984.6 6028.3 6071.3 6092.1 5874.9 5927.4 5936.3 5945.0 5969.2 5971.6 6032.4 6039.2 6040.3 6044.0 5777.1 5857.9 5933.4 5993.8 6017.0 6049.7 6054.8 6056.5 6066.9 6104.9 4662.3 4695.2 4705.5 4707.4 4729.5 3988.1 3997.7 4080.5 4083.8 4125.4 5852.1 5873.8 5922.4 5925.0 5943.0 6044.2 6105.5 6113.3 6116.1 6122.6 5686.6 5898.6 5902.8 5908.9 6047.2 5216.2 5223.7 5233.3 5233.8 5236.3 6293.7 6326.0 6373.6 6394.0 6414.4 5885.9 5943.3 5961.3 5981.5 5998.0 6189.2 6235.8 6239.2 6244.1 6283.7 5906.4 5958.8 5979.9 5998.3 6021.8 5823.7 5867.2 5929.2 5946.4 6046.7 5861.3 5864.9 5873.2 5894.2 5922.3 5813.7 5823.5 5849.0 5868.3 5870.6 5774.7 5820.9 5822.5 5838.0 5843.4 5687.1 5934.8 5975.2 5976.6 6015.8 5820.0 5821.2 5845.2 5846.2 5870.2 20:05:00 INFO - PROCESS | 26659 | 20:05:00 INFO - PROCESS | 26659 | [#1] ext.html Cycles:180 Average:64512.29 Median:40842.90 stddev:128421.39 (314.4%) stddev-sans-first:128691.94 20:05:00 INFO - PROCESS | 26659 | Values: 581.6 609.4 639.9 657.6 695.5 43194.8 47653.5 47675.3 47701.5 47868.8 48560.3 49175.0 49338.8 49363.5 49393.3 9276.6 9448.6 9477.6 10641.9 10972.4 11024.5 11092.3 11102.8 11118.5 11142.2 11159.1 11196.1 11200.7 11203.6 11210.4 11041.6 11091.7 11124.0 11148.8 11156.2 11034.4 11105.7 11114.8 11119.6 11129.6 42121.0 42176.6 42233.4 42554.1 42698.4 4262.4 4520.5 4555.1 4667.8 4708.1 32253.4 32324.0 32692.8 33158.2 33398.3 4338.8 4347.4 4392.1 4403.4 4492.6 354208.0 354728.0 356157.0 356889.0 357670.0 61182.0 61553.7 61632.4 61706.7 61771.4 62956.7 62963.7 63274.4 63537.7 63849.4 18490.4 18751.2 18846.2 18865.1 18890.3 13423.5 13429.9 14258.6 14265.7 14363.5 19269.1 19652.7 19841.2 19855.2 20015.9 7757.5 7768.1 7799.2 7836.6 7909.7 932.6 941.9 948.4 963.3 968.9 33408.7 33579.0 33642.7 33892.1 34225.8 1060.4 1170.7 1197.5 1198.1 1209.5 17353.5 17612.5 17747.6 17782.4 17844.3 514756.0 515885.0 519055.0 523370.0 523557.0 62381.7 62516.0 62830.7 63059.1 63182.0 1518.3 1554.8 1565.7 1567.9 1583.1 30161.5 31173.8 31296.7 31309.8 31702.2 52403.0 55640.4 57880.7 58062.4 65311.3 548519.0 553719.0 554682.0 556137.0 556157.0 29334.3 29378.4 29425.7 31904.8 43600.0 47435.8 47705.8 47717.5 47964.0 49517.8 40366.2 40714.0 41316.6 41875.6 42103.4 39684.8 40284.0 41257.6 41322.0 41809.0 39995.0 40971.8 41126.4 41361.0 41460.0 34294.0 35387.8 35945.0 35955.5 36086.8 25963.7 26412.2 26929.3 27071.5 27206.5 20:05:00 INFO - PROCESS | 26659 | 20:05:00 INFO - PROCESS | 26659 | [#2] jquery.html Cycles:180 Average:36101.30 Median:26939.59 stddev:109237.46 (405.5%) stddev-sans-first:109511.08 20:05:00 INFO - PROCESS | 26659 | Values: 442.5 446.8 448.7 453.2 459.1 20554.1 20825.0 21153.5 22216.6 22265.0 22433.7 23132.3 23202.5 23339.4 23496.9 6091.9 6236.8 6271.9 6332.9 6346.0 6337.7 6527.1 6532.9 6540.0 6558.4 6378.0 6464.2 6486.8 6490.3 6565.3 6330.6 6500.9 6504.1 6580.8 6595.4 6335.1 6374.1 6381.7 6387.4 6389.3 15763.6 18892.8 26580.9 27298.3 27309.9 2793.1 2836.0 2888.3 2905.9 2917.3 10773.8 10945.3 11684.5 12389.9 15408.9 2035.6 2062.6 2074.6 2077.4 2081.6 100711.5 102110.0 102249.5 102425.8 104587.8 12469.6 12759.2 12845.2 12883.9 13061.0 18527.1 18544.4 18556.3 18626.8 18648.0 9176.3 9468.8 9504.6 9621.8 9650.0 8969.8 9014.3 9025.7 9041.9 9175.1 5363.1 5423.9 5448.6 5471.1 5495.3 2191.4 2191.9 2205.8 2260.9 2282.6 945.1 959.6 964.2 966.6 977.9 20306.8 21152.3 21480.9 21575.4 21575.7 969.1 975.8 978.6 980.9 992.4 11456.0 11784.0 11844.0 11873.9 11976.2 639036.0 647395.0 661004.0 667158.0 697061.0 114187.4 114405.4 114792.0 115252.0 118968.4 1080.3 1114.9 1130.7 1137.4 1140.0 17954.8 18481.1 18534.6 18548.8 18599.3 47110.0 47273.0 47296.8 48572.5 49684.8 66708.3 66804.0 66865.7 67505.0 67724.3 8776.9 8953.6 8954.4 9160.0 9345.0 8960.7 12598.1 12653.2 12727.8 13223.4 11269.9 11421.5 11428.6 11652.5 11734.2 10455.5 10783.9 10801.5 11033.1 11206.6 11132.4 11767.3 11843.5 11884.0 11967.2 8740.2 8873.2 8882.8 8951.4 8981.6 9682.6 10915.1 10936.7 10942.3 11214.3 20:05:00 INFO - PROCESS | 26659 | 20:05:00 INFO - PROCESS | 26659 | [#3] mootools.html Cycles:180 Average:5857.71 Median:5307.86 stddev:3222.61 (60.7%) stddev-sans-first:3214.99 20:05:00 INFO - PROCESS | 26659 | Values: 1497.2 1514.6 1514.6 1522.1 1527.3 8129.6 8401.3 8666.1 9177.2 9192.4 8694.2 8949.3 8955.1 9203.4 9203.8 2484.5 2518.5 2537.8 2539.0 2543.3 2450.1 2514.7 2515.8 2518.4 2521.4 2422.3 2437.6 2450.1 2450.5 2455.1 2361.4 2364.0 2367.3 2383.1 2385.9 2398.0 2399.5 2416.7 2421.0 2457.0 8825.0 8867.6 8885.2 8894.5 8925.2 5482.5 5622.1 5624.4 5624.8 5637.0 3364.1 3456.5 3504.8 3508.4 3541.6 1404.0 1424.0 1443.1 1449.1 1489.4 11414.1 11516.7 11688.6 11963.8 11968.6 4612.3 4633.2 4746.9 4750.1 4791.0 9783.0 9885.1 9892.6 9908.0 9931.6 5604.7 5622.2 5626.4 5637.8 5649.0 5060.2 5198.9 5254.9 5287.8 5310.4 4052.9 4072.6 4099.9 4122.0 4155.6 1159.2 1165.9 1166.4 1176.7 1188.5 972.4 1005.8 1013.3 1014.4 1025.2 6097.5 6113.2 6196.6 6223.0 6226.0 636.8 651.2 651.9 665.7 667.4 3854.6 3875.2 3910.5 3955.3 3975.2 10540.5 10855.9 10908.5 10924.2 10939.3 10783.5 10806.9 10830.9 10837.5 10839.5 8144.6 8338.1 8416.7 8585.2 8586.2 6068.5 6320.7 6332.2 6346.1 6365.5 9591.2 9748.9 9872.5 9887.6 10059.0 10100.9 10101.5 10152.5 10181.6 10202.5 7142.5 7936.0 7947.4 7981.3 8110.9 8750.8 8786.0 8794.1 8817.9 8825.5 7654.2 7704.6 7706.5 7724.2 7750.1 7405.7 7443.4 7467.1 7543.4 7629.6 6782.8 6795.5 6838.1 6875.5 6887.8 5265.3 5305.3 5387.5 5393.9 5397.7 5419.3 5445.9 5479.1 5522.8 5538.7 20:05:00 INFO - PROCESS | 26659 | 20:05:00 INFO - PROCESS | 26659 | [#4] prototype.html Cycles:180 Average:4869.05 Median:5519.07 stddev:1401.72 (25.4%) stddev-sans-first:1365.26 20:05:00 INFO - PROCESS | 26659 | Values: 417.6 418.3 418.8 428.0 430.9 5341.8 5511.3 5514.8 5570.6 5643.8 5323.1 5403.2 5492.8 5507.0 5514.4 4186.9 4304.8 4308.2 4376.9 4384.4 4284.5 4301.3 4308.1 4308.4 4317.7 4266.8 4296.4 4303.4 4320.7 4373.0 4191.4 4294.5 4348.4 4354.3 4359.6 3810.6 3814.7 3817.2 3818.8 3855.7 5436.6 5438.5 5439.6 5472.6 5490.2 4837.7 5001.6 5016.9 5041.0 5055.9 5740.1 5792.0 5797.8 5822.1 5826.2 4275.4 4282.7 4291.6 4298.5 4304.4 5828.7 5993.0 6057.3 6095.2 6137.9 4292.7 4298.7 4341.1 4350.1 4358.6 4414.2 4418.4 4419.2 4422.0 4433.0 4834.4 4942.2 4954.4 4964.9 4973.9 5738.3 5795.7 5796.9 5802.3 5808.2 1462.6 1466.1 1470.6 1475.9 1485.4 970.1 1005.4 1022.1 1023.6 1043.5 5487.8 5498.4 5509.1 5523.4 5535.0 5751.0 5761.5 5762.7 5773.5 5795.8 5458.5 5526.4 5547.5 5577.2 5624.4 3031.7 3089.2 3089.6 3097.6 3102.7 5855.7 5992.9 6042.1 6043.3 6054.5 5812.7 5856.4 5862.5 5899.4 5909.2 5977.6 6001.2 6006.6 6020.6 6027.2 5614.6 5620.2 5703.2 5733.6 5749.0 5631.9 5649.1 5650.7 5657.5 5677.5 5947.8 5986.5 6122.0 6137.8 6178.9 4263.6 4324.6 4329.3 4334.4 4345.7 5765.4 5969.8 5984.4 5989.6 6045.2 5774.8 5788.7 5795.4 5812.5 5813.2 5728.8 5806.9 5810.3 5811.9 5828.0 5570.2 5661.6 5714.9 5778.6 5786.3 5786.5 5790.3 5827.4 5874.8 5907.7 5565.2 5739.4 5762.4 5783.4 5792.3 20:05:00 INFO - PROCESS | 26659 | 20:05:00 INFO - PROCESS | 26659 | [#5] yui.html Cycles:180 Average:18696.67 Median:4015.33 stddev:22890.96 (570.1%) stddev-sans-first:22915.66 20:05:00 INFO - PROCESS | 26659 | Values: 785.7 805.8 829.5 924.6 938.9 16548.4 17643.5 17874.4 17991.1 17999.9 16639.6 16732.8 17302.6 17404.7 17956.5 814.6 825.6 842.9 843.4 844.6 825.0 829.2 830.9 830.9 831.1 869.9 872.2 872.6 876.2 876.8 872.5 873.3 874.5 875.2 875.7 639.6 641.0 642.6 644.0 644.3 16066.8 16178.4 16201.5 17840.1 17995.0 16030.9 16288.9 16335.1 16343.0 16500.3 13418.3 13488.3 13578.2 13747.4 13825.4 3986.2 3987.2 3988.9 4006.9 4023.8 79261.1 79462.2 80179.0 80647.2 81053.0 12444.6 12530.0 12607.8 12641.5 12779.4 23544.6 23662.0 23663.6 23669.4 23737.0 8160.5 8265.9 8299.3 8307.8 8524.4 5065.5 5077.7 5089.1 5108.3 5110.7 3681.7 3732.3 3738.2 3792.7 3795.2 563.1 568.4 571.7 575.2 579.0 871.1 883.4 893.5 896.4 898.7 11090.2 11413.7 11443.7 11584.7 11656.6 838.5 842.9 848.8 873.0 878.1 5210.5 5456.9 5497.1 5533.2 5538.6 80959.6 82161.0 82257.2 84011.6 86902.0 68341.7 69978.0 71807.0 72636.3 73505.3 63545.4 64298.7 64429.4 64470.4 65573.7 11552.4 12043.3 12170.9 12446.7 12448.9 36589.6 39562.0 40928.8 41420.0 42163.6 54607.5 54679.0 56220.4 56339.4 56997.7 14164.2 14190.8 14199.0 14206.9 14418.9 16102.5 16257.6 16408.8 16643.3 16831.1 15517.9 15594.4 15944.2 16162.7 16332.2 15074.5 15192.2 15289.8 15677.5 15961.7 15200.2 15249.2 15349.4 15372.6 15582.3 12533.6 13304.3 13409.2 13409.5 13524.4 12058.2 12098.3 12262.6 12301.4 12411.6 20:05:00 INFO - PROCESS | 26659 | -------- Summary: end -------- 20:05:00 INFO - PROCESS | 26659 | 20:05:01 INFO - TEST-INFO | 26659: exit 0 20:05:01 INFO - TEST-OK | dromaeo_css | took 1112280ms 20:05:01 INFO - TEST-START | kraken 20:05:01 INFO - operating with platform_type : linux_ 20:05:01 INFO - Initialising browser for kraken test... 20:05:01 INFO - TEST-INFO | started process 27030 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEOV_uu/profile http://localhost:53839/getInfo.html) 20:05:06 INFO - PROCESS | 27030 | __metrics Screen width/height:1600/1200 20:05:06 INFO - PROCESS | 27030 | colorDepth:24 20:05:06 INFO - PROCESS | 27030 | Browser inner width/height: 1024/697 20:05:06 INFO - PROCESS | 27030 | __metrics 20:05:07 INFO - PROCESS | 27030 | 1486353907087 addons.xpi WARN Exception running bootstrap method shutdown on shield-recipe-client@mozilla.org: ReferenceError: LogManager is not defined (resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:65:3) JS Stack trace: this.shutdown@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@bootstrap.js:65:3 < callBootstrapMethod@XPIProvider.jsm:4903:11 < observe@XPIProvider.jsm:2884:15 < permitUnload@remote-browser.xml:353:13 < CanCloseWindow@browser.js:6277:36 < canClose@browser.js:5143:12 < forceQuit@jar:file:///tmp/tmpEOV_uu/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpEOV_uu/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpEOV_uu/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpEOV_uu/profile/extensions/talos-powers@TalosPowersService.js:55:9 20:05:07 ERROR - PROCESS | 27030 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 20:05:07 INFO - TEST-INFO | 27030: exit 0 20:05:07 INFO - Browser initialized. 20:05:07 INFO - Running cycle 1/1 for kraken test... 20:05:07 INFO - TEST-INFO | started process 27161 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpEOV_uu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:05:19 INFO - PROCESS | 27161 | RSS: Main: 144470016 20:05:19 INFO - PROCESS | 27161 | 20:05:22 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:53839/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53839/tests/kraken/driver.html?testName=audio-beat-detection) 20:05:23 INFO - PROCESS | 27161 | RSS: Main: 151326720 20:05:23 INFO - PROCESS | 27161 | 20:05:25 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:53839/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53839/tests/kraken/driver.html?testName=audio-dft) 20:05:26 INFO - PROCESS | 27161 | RSS: Main: 149590016 20:05:26 INFO - PROCESS | 27161 | 20:05:29 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:53839/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53839/tests/kraken/driver.html?testName=audio-fft) 20:05:29 INFO - PROCESS | 27161 | RSS: Main: 150392832 20:05:29 INFO - PROCESS | 27161 | 20:05:31 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:53839/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53839/tests/kraken/driver.html?testName=audio-oscillator) 20:05:32 INFO - PROCESS | 27161 | RSS: Main: 150224896 20:05:32 INFO - PROCESS | 27161 | 20:05:34 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:53839/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53839/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:05:35 INFO - PROCESS | 27161 | RSS: Main: 150683648 20:05:35 INFO - PROCESS | 27161 | 20:05:38 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:53839/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53839/tests/kraken/driver.html?testName=imaging-darkroom) 20:05:38 INFO - PROCESS | 27161 | RSS: Main: 153444352 20:05:38 INFO - PROCESS | 27161 | 20:05:42 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:53839/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53839/tests/kraken/driver.html?testName=imaging-desaturate) 20:05:42 INFO - PROCESS | 27161 | RSS: Main: 153890816 20:05:42 INFO - PROCESS | 27161 | 20:05:45 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:53839/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53839/tests/kraken/driver.html?testName=json-parse-financial) 20:05:46 INFO - PROCESS | 27161 | RSS: Main: 152764416 20:05:46 INFO - PROCESS | 27161 | 20:05:47 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:53839/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53839/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:05:48 INFO - PROCESS | 27161 | RSS: Main: 152121344 20:05:48 INFO - PROCESS | 27161 | 20:05:50 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:53839/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53839/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:05:51 INFO - PROCESS | 27161 | RSS: Main: 152481792 20:05:51 INFO - PROCESS | 27161 | 20:05:53 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:53839/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53839/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:05:53 INFO - PROCESS | 27161 | RSS: Main: 152793088 20:05:53 INFO - PROCESS | 27161 | 20:05:56 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:53839/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53839/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:05:56 INFO - PROCESS | 27161 | RSS: Main: 153104384 20:05:56 INFO - PROCESS | 27161 | 20:05:59 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:53839/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53839/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:06:00 INFO - PROCESS | 27161 | RSS: Main: 153497600 20:06:00 INFO - PROCESS | 27161 | 20:06:01 INFO - PROCESS | 27161 | Cycle 1(1): loaded http://localhost:53839/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53839/tests/kraken/driver.html?testName=ai-astar) 20:06:02 INFO - PROCESS | 27161 | RSS: Main: 154927104 20:06:02 INFO - PROCESS | 27161 | 20:06:02 INFO - PROCESS | 27161 | __start_tp_report 20:06:02 INFO - PROCESS | 27161 | _x_x_mozilla_page_load 20:06:02 INFO - PROCESS | 27161 | _x_x_mozilla_page_load_details 20:06:02 INFO - PROCESS | 27161 | |i|pagename|runs| 20:06:02 INFO - PROCESS | 27161 | |0;ai-astar;104;116;113;112;116;113;112;113;113;119 20:06:02 INFO - PROCESS | 27161 | |1;audio-beat-detection;148;120;121;165;119;117;118;119;141;121 20:06:02 INFO - PROCESS | 27161 | |2;audio-dft;160;164;162;162;162;161;162;161;163;161 20:06:02 INFO - PROCESS | 27161 | |3;audio-fft;74;77;74;115;75;75;76;76;92;76 20:06:02 INFO - PROCESS | 27161 | |4;audio-oscillator;83;82;100;82;83;83;98;82;82;105 20:06:02 INFO - PROCESS | 27161 | |5;imaging-gaussian-blur;117;118;117;118;118;118;118;118;117;118 20:06:02 INFO - PROCESS | 27161 | |6;imaging-darkroom;148;149;149;151;148;147;148;148;150;148 20:06:02 INFO - PROCESS | 27161 | |7;imaging-desaturate;97;103;96;96;95;96;96;95;97;96 20:06:02 INFO - PROCESS | 27161 | |8;json-parse-financial;55;56;54;56;55;55;54;59;55;54 20:06:02 INFO - PROCESS | 27161 | |9;json-stringify-tinderbox;67;67;64;65;65;65;65;65;68;66 20:06:02 INFO - PROCESS | 27161 | |10;stanford-crypto-aes;75;83;75;77;77;75;75;76;80;75 20:06:02 INFO - PROCESS | 27161 | |11;stanford-crypto-ccm;128;123;121;130;120;127;122;118;164;123 20:06:02 INFO - PROCESS | 27161 | |12;stanford-crypto-pbkdf2;168;155;157;158;165;157;158;157;155;161 20:06:02 INFO - PROCESS | 27161 | |13;stanford-crypto-sha256-iterative;61;61;68;60;61;60;61;60;61;60 20:06:02 INFO - PROCESS | 27161 | __end_tp_report 20:06:02 INFO - PROCESS | 27161 | __start_cc_report 20:06:02 INFO - PROCESS | 27161 | _x_x_mozilla_cycle_collect,725 20:06:02 INFO - PROCESS | 27161 | __end_cc_report 20:06:02 INFO - PROCESS | 27161 | __startTimestamp1486353962124__endTimestamp 20:06:02 INFO - PROCESS | 27161 | 20:06:02 INFO - PROCESS | 27161 | ------- Summary: start ------- 20:06:02 INFO - PROCESS | 27161 | Number of tests: 14 20:06:02 INFO - PROCESS | 27161 | 20:06:02 INFO - PROCESS | 27161 | [#0] ai-astar Cycles:10 Average:113.10 Median:113.00 stddev:3.90 (3.5%) stddev-sans-first:2.37 20:06:02 INFO - PROCESS | 27161 | Values: 104.0 116.0 113.0 112.0 116.0 113.0 112.0 113.0 113.0 119.0 20:06:02 INFO - PROCESS | 27161 | 20:06:02 INFO - PROCESS | 27161 | [#1] audio-beat-detection Cycles:10 Average:128.90 Median:121.00 stddev:16.58 (13.7%) stddev-sans-first:16.08 20:06:02 INFO - PROCESS | 27161 | Values: 148.0 120.0 121.0 165.0 119.0 117.0 118.0 119.0 141.0 121.0 20:06:02 INFO - PROCESS | 27161 | 20:06:02 INFO - PROCESS | 27161 | [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:1.14 (0.7%) stddev-sans-first:1.00 20:06:02 INFO - PROCESS | 27161 | Values: 160.0 164.0 162.0 162.0 162.0 161.0 162.0 161.0 163.0 161.0 20:06:02 INFO - PROCESS | 27161 | 20:06:02 INFO - PROCESS | 27161 | [#3] audio-fft Cycles:10 Average:81.00 Median:76.00 stddev:13.07 (17.2%) stddev-sans-first:13.62 20:06:02 INFO - PROCESS | 27161 | Values: 74.0 77.0 74.0 115.0 75.0 75.0 76.0 76.0 92.0 76.0 20:06:02 INFO - PROCESS | 27161 | 20:06:02 INFO - PROCESS | 27161 | [#4] audio-oscillator Cycles:10 Average:88.00 Median:82.50 stddev:9.14 (11.1%) stddev-sans-first:9.51 20:06:02 INFO - PROCESS | 27161 | Values: 83.0 82.0 100.0 82.0 83.0 83.0 98.0 82.0 82.0 105.0 20:06:02 INFO - PROCESS | 27161 | 20:06:02 INFO - PROCESS | 27161 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 20:06:02 INFO - PROCESS | 27161 | Values: 117.0 118.0 117.0 118.0 118.0 118.0 118.0 118.0 117.0 118.0 20:06:02 INFO - PROCESS | 27161 | 20:06:02 INFO - PROCESS | 27161 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:148.50 stddev:1.17 (0.8%) stddev-sans-first:1.22 20:06:02 INFO - PROCESS | 27161 | Values: 148.0 149.0 149.0 151.0 148.0 147.0 148.0 148.0 150.0 148.0 20:06:02 INFO - PROCESS | 27161 | 20:06:02 INFO - PROCESS | 27161 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.00 stddev:2.31 (2.4%) stddev-sans-first:2.45 20:06:02 INFO - PROCESS | 27161 | Values: 97.0 103.0 96.0 96.0 95.0 96.0 96.0 95.0 97.0 96.0 20:06:02 INFO - PROCESS | 27161 | 20:06:02 INFO - PROCESS | 27161 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:55.00 stddev:1.49 (2.7%) stddev-sans-first:1.58 20:06:02 INFO - PROCESS | 27161 | Values: 55.0 56.0 54.0 56.0 55.0 55.0 54.0 59.0 55.0 54.0 20:06:02 INFO - PROCESS | 27161 | 20:06:02 INFO - PROCESS | 27161 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:65.50 stddev:1.25 (1.9%) stddev-sans-first:1.24 20:06:02 INFO - PROCESS | 27161 | Values: 67.0 67.0 64.0 65.0 65.0 65.0 65.0 65.0 68.0 66.0 20:06:02 INFO - PROCESS | 27161 | 20:06:02 INFO - PROCESS | 27161 | [#10] stanford-crypto-aes Cycles:10 Average:76.80 Median:76.50 stddev:2.70 (3.5%) stddev-sans-first:2.78 20:06:02 INFO - PROCESS | 27161 | Values: 75.0 83.0 75.0 77.0 77.0 75.0 75.0 76.0 80.0 75.0 20:06:02 INFO - PROCESS | 27161 | 20:06:02 INFO - PROCESS | 27161 | [#11] stanford-crypto-ccm Cycles:10 Average:127.60 Median:125.00 stddev:13.33 (10.7%) stddev-sans-first:14.13 20:06:02 INFO - PROCESS | 27161 | Values: 128.0 123.0 121.0 130.0 120.0 127.0 122.0 118.0 164.0 123.0 20:06:02 INFO - PROCESS | 27161 | 20:06:02 INFO - PROCESS | 27161 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:159.10 Median:158.00 stddev:4.31 (2.7%) stddev-sans-first:3.14 20:06:02 INFO - PROCESS | 27161 | Values: 168.0 155.0 157.0 158.0 165.0 157.0 158.0 157.0 155.0 161.0 20:06:02 INFO - PROCESS | 27161 | 20:06:02 INFO - PROCESS | 27161 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:61.30 Median:61.00 stddev:2.41 (3.9%) stddev-sans-first:2.55 20:06:02 INFO - PROCESS | 27161 | Values: 61.0 61.0 68.0 60.0 61.0 60.0 61.0 60.0 61.0 60.0 20:06:02 INFO - PROCESS | 27161 | -------- Summary: end -------- 20:06:02 INFO - PROCESS | 27161 | 20:06:03 INFO - TEST-INFO | 27161: exit 0 20:06:03 INFO - TEST-OK | kraken | took 61398ms 20:06:03 INFO - SUITE-END | took 1173s 20:06:03 INFO - Completed test suite (00:19:33) 20:06:03 INFO - javascript benchmark 20:06:03 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7660.544755677435, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3283.8358082095892, 3304.90085297441, 3314.514842004468, 3320.5185248139037, 3338.732901367891, 5589.74846131924, 5599.832005039845, 5619.831405057855, 5637.830865074044, 5643.689597072164, 5585.469380408855, 5596.832095037145, 5655.519280861132, 5662.971685141579, 5665.433456654332, 4970.850874473772, 5044.520770526794, 5051.848444546669, 5090.541851233388, 5138.845834624948, 5103.183490641498, 5129.333186685725, 5140.306058682087, 5152.845414637548, 5154.793808247666, 4924.876878078041, 4932.728699921503, 5122.538971492565, 5136.512031357015, 5151.021305951876, 5036.571891389236, 5058.165402708549, 5058.620603454738, 5093.439721630618, 5146.150885103953, 4981.078500477423, 5062.645614806965, 5067.062593420229, 5067.417247016603, 5085.389753229599, 5463.7814487420455, 5595.776168953237, 5596.0, 5673.886522269531, 5695.288088988877, 5908.852278693067, 5931.436513531251, 5933.821985340447, 5968.37332080134, 6061.302950160743, 6036.396360363972, 6047.546434017422, 6056.636601803906, 6070.969645151746, 6082.148499210114, 5673.886522269531, 5677.40387259336, 5680.460356266148, 5680.801171959003, 5681.375048744635, 5909.645421274738, 5984.611000284967, 6028.306744724325, 6071.332153463116, 6092.147099406086, 5874.853128671817, 5927.3776253493625, 5936.317323507766, 5944.970275148597, 5969.224000879858, 5971.641701497837, 6032.426919442646, 6039.184710064173, 6040.335563088057, 6043.969780151071, 5777.104548794943, 5857.912131318034, 5933.406659334032, 5993.790217342372, 6017.0, 6049.667268300285, 6054.848628784228, 6056.515478761688, 6066.939330606638, 6104.938950610526, 4662.300654901792, 4695.178343789823, 4705.458872229738, 4707.411573553306, 4729.4797572267025, 3988.062805240766, 3997.6601988831276, 4080.469538959916, 4083.7549747015273, 4125.401816736557, 5852.063669812809, 5873.765049397976, 5922.407759224043, 5924.9703751480965, 5943.049112142123, 6044.24446944132, 6105.511559075263, 6113.29697084841, 6116.113163591343, 6122.571420000646, 5686.601937864392, 5898.64608123514, 5902.76388944446, 5908.852278692981, 6047.213862197887, 5216.217567364925, 5223.738813059332, 5233.2935053768015, 5233.816816411408, 5236.266922630834, 6293.653849038347, 6326.0, 6373.6175829450385, 6393.968030159819, 6414.358564143548, 5885.852853678693, 5943.346231914573, 5961.314448838439, 5981.52147828164, 5997.970010149921, 6189.164462797465, 6235.781747638811, 6239.220097487814, 6244.094606281973, 6283.74865005413, 5906.40935906406, 5958.821235362946, 5979.880402392015, 5998.25021872266, 6021.819345419644, 5823.7379317929945, 5867.178594996619, 5929.229200204119, 5946.375630558729, 6046.667433291035, 5861.296644402699, 5864.853378665567, 5873.177755114202, 5894.174815525916, 5922.289325280994, 5813.709314534171, 5823.505002074871, 5848.970755146197, 5868.3251426086545, 5870.618409803349, 5774.711264436845, 5820.912686309624, 5822.475977162076, 5838.036723940502, 5843.386444423444, 5687.146927960839, 5934.762609495572, 5975.223220981418, 5976.641401515923, 6015.849603759766, 5820.039693450533, 5821.155932389865, 5845.152452894392, 5846.239988801429, 5870.207521984477], "value": 5558.284283095345, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.6103210848731, 609.4423602403799, 639.945604623607, 657.6087228099279, 695.4888157204457, 43194.78402607986, 47653.52346476534, 47675.28487072692, 47701.52298477014, 47868.76065619667, 48560.271595926, 49175.0, 49338.75330623342, 49363.50636493634, 49393.259101113515, 9276.628934842598, 9448.57481413338, 9477.573509192103, 10641.893581064167, 10972.396518191495, 11024.5038973246, 11092.279001864894, 11102.833457498144, 11118.499667514981, 11142.164337674667, 11159.051480624157, 11196.104311655088, 11200.719982000475, 11203.551857925673, 11210.383428911407, 11041.613543525938, 11091.667249982473, 11124.0, 11148.777024459465, 11156.16328775345, 11034.448277586089, 11105.72235694106, 11114.777704445865, 11119.610813621484, 11129.610463633815, 42121.0, 42176.57823421788, 42233.366499502226, 42554.148917021485, 42698.359524607156, 4262.360645903108, 4520.457545094577, 4555.111753208126, 4667.836625718118, 4708.128996135726, 32253.35493290121, 32324.0, 32692.836535817405, 33158.17104572381, 33398.33203335944, 4338.848140315105, 4347.37348250889, 4392.143532011259, 4403.4495688039, 4492.61812745917, 354208.0, 354728.0, 356157.0, 356889.0, 357670.0, 61182.0, 61553.69223153855, 61632.383676162666, 61706.69146654238, 61771.38228617746, 62956.68521657454, 62963.685181574714, 63274.367256327765, 63537.68231158907, 63849.36150638527, 18490.445286641152, 18751.156197971122, 18846.151923163492, 18865.056747162587, 18890.3388381406, 13423.463061477432, 13429.932850335881, 14258.572242832732, 14265.714685706227, 14363.497277595234, 19269.132889020028, 19652.70520942187, 19841.20635174577, 19855.205791768167, 20015.899920500306, 7757.53454792703, 7768.096816280047, 7799.181085986003, 7836.647350869224, 7909.7231596893835, 932.6129656192604, 941.8916824565125, 948.4119845695575, 963.3064193780467, 968.864358989742, 33408.665913340556, 33579.0, 33642.663573363956, 33892.13516672044, 34225.828870855985, 1060.3955745225148, 1170.7073231692077, 1197.5209916033657, 1198.1313547677864, 1209.4738788626976, 17353.479395618153, 17612.471625851245, 17747.645047099242, 17782.377616783608, 17844.286228550973, 514756.0, 515885.0, 519055.0, 523370.0, 523557.0, 62381.68809156016, 62516.0, 62830.68584657047, 63059.05411418832, 63182.0, 1518.2788175616715, 1554.8367421420814, 1565.6790357976815, 1567.8902476826513, 1583.073901767456, 30161.547576785928, 31173.844130780108, 31296.687033129376, 31309.8434507826, 31702.207444813143, 52403.0, 55640.44359556514, 57880.71059644675, 58062.4193758057, 65311.346886530526, 548519.0, 553719.0, 554682.0, 556137.0, 556157.0, 29334.26664333409, 29378.412431750818, 29425.705742942297, 31904.84047579747, 43600.0, 47435.76282118567, 47705.761471192425, 47717.52282477131, 47964.0, 49517.752411237714, 40366.1926761469, 40714.0, 41316.586834131274, 41875.58124418839, 42103.36844947267, 39684.801575991936, 40284.0, 41257.58742412538, 41322.0, 41809.0, 39995.0, 40971.79514102411, 41126.383104254055, 41361.0, 41460.0, 34294.0, 35387.839424520476, 35945.0, 35955.46066809052, 36086.819565902006, 25963.74036259613, 26412.171009885853, 26929.326766830985, 27071.45857082808, 27206.455870882866], "value": 21657.552819797358, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [442.52207615774967, 446.8034065011395, 448.74870072759245, 453.21819860740226, 459.0932907507672, 20554.075066622, 20824.99999999998, 21153.471163220926, 22216.555668886613, 22264.99807508662, 22433.66349504759, 23132.30603081906, 23202.535949281006, 23339.416514587145, 23496.88251558744, 6091.908621370672, 6236.750529978795, 6271.937280627204, 6332.905006424908, 6346.01636746305, 6337.746490140389, 6527.086207930894, 6532.902006469907, 6539.967300163493, 6558.409743123118, 6377.968110159442, 6464.191976003, 6486.805395838132, 6490.318516555764, 6565.343465653445, 6330.620162790201, 6500.934990650104, 6504.121943537609, 6580.835479113012, 6595.373439523214, 6335.081413195107, 6374.107624932467, 6381.68091595423, 6387.393197646216, 6389.265234498046, 15763.605909852231, 18892.811071889242, 26580.86709566459, 27298.317542061606, 27309.863450682817, 2793.064323451646, 2835.957460638092, 2888.321244507539, 2905.8982935597364, 2917.3144311086876, 10773.78452430947, 10945.343279403261, 11684.474198660995, 12389.876101239053, 15408.922955385264, 2035.592881423721, 2062.6287268291703, 2074.5643414882893, 2077.356019633918, 2081.573277478113, 100711.49644251732, 102110.0, 102249.4887525565, 102425.83297576189, 104587.81648734042, 12469.563565275172, 12759.170653907466, 12845.229286242855, 12883.935580322039, 13061.0, 18527.07364631763, 18544.443666690022, 18556.257749689863, 18626.81373186251, 18648.0, 9176.265898728087, 9468.763280918032, 9504.619815207452, 9621.807563848824, 9649.951750241204, 8969.775755606162, 9014.323925705598, 9025.736396904438, 9041.864372034424, 9175.08249175077, 5363.115086010765, 5423.918641220384, 5448.591355648342, 5471.097268950579, 5495.313085864267, 2191.41927389242, 2191.8684878907316, 2205.790449907256, 2260.8982595783227, 2282.6005449046684, 945.1210374351919, 959.5681943125481, 964.1997142371955, 966.6423423333271, 977.9364341317792, 20306.796932030786, 21152.259670911444, 21480.892595536923, 21575.35273941784, 21575.67636485454, 969.1084202533686, 975.8145952269189, 978.5908292059554, 980.9460479673686, 992.3946392700446, 11456.026237769716, 11784.0, 11844.0, 11873.881261187451, 11976.161668683282, 639036.0, 647395.0, 661004.0, 667158.0, 697061.0, 114187.42906285582, 114405.4279728596, 114792.0, 115252.0, 118968.40515797366, 1080.2978064258139, 1114.899659030691, 1130.717320669849, 1137.3517095255625, 1139.9772004559863, 17954.820451795837, 18481.075946202905, 18534.629307414045, 18548.814511854707, 18599.256029758657, 47110.0, 47273.0, 47296.76351618358, 48572.514274856796, 49684.751576241884, 66708.33229169309, 66804.0, 66865.66567167133, 67505.0, 67724.3227567718, 8776.912230877864, 8953.597088130919, 8954.417962832395, 9160.038195989326, 9345.0, 8960.731178064669, 12598.118131730691, 12653.177543459646, 12727.80908286358, 13223.404946777226, 11269.91424630723, 11421.543138274375, 11428.599999000327, 11652.475638596114, 11734.178607497393, 10455.529501172314, 10783.946080269863, 10801.513931873242, 11033.117350611772, 11206.551737930391, 11132.443377830914, 11767.293962362286, 11843.467043983213, 11884.0, 11967.222130561486, 8740.213380795505, 8873.157050080232, 8882.822343552964, 8951.373403861668, 8981.595828187877, 9682.56428460707, 10915.072218861169, 10936.671899842699, 10942.343459392461, 11214.271072380268], "value": 10179.07621844886, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1497.2438918346247, 1514.5759187427518, 1514.621344663834, 1522.132384540812, 1527.2898102382394, 8129.55287459191, 8401.327893768499, 8666.090060543638, 9177.219936305413, 9192.402493837904, 8694.21752042316, 8949.328800339968, 8955.104489551042, 9203.447793132416, 9203.815923681523, 2484.5030993801265, 2518.508890766301, 2537.8223524353302, 2538.987305063472, 2543.2878793937634, 2450.0567281596623, 2514.660520829683, 2515.7987361011164, 2518.3704073981503, 2521.407469244726, 2422.2612103308484, 2437.5856104462196, 2450.105711415338, 2450.534398464295, 2455.1407007547305, 2361.3978435498925, 2363.988180059106, 2367.2543148908126, 2383.082513232418, 2385.940351491209, 2398.040783686522, 2399.4841109161616, 2416.685830841997, 2421.0436877433317, 2457.0, 8824.955875220647, 8867.556622168866, 8885.155910188521, 8894.510801905893, 8925.152110549487, 5482.533984611313, 5622.072358060915, 5624.3531993820825, 5624.831255062355, 5637.0, 3364.142143753352, 3456.5333679953137, 3504.8422820972864, 3508.4035713928693, 3541.645835416438, 1403.9789403158961, 1423.9715205695932, 1443.0620096937075, 1449.0581122270503, 1489.4116823854624, 11414.086873050219, 11516.712082197928, 11688.590899318484, 11963.760724785543, 11968.640940771791, 4612.30815377696, 4633.166030114544, 4746.905061898743, 4750.14497390473, 4791.041791641685, 9783.0, 9885.110340069285, 9892.60429582823, 9907.950460247652, 9931.602735890483, 5604.663720176803, 5622.156676498476, 5626.409227031185, 5637.802676906289, 5649.0396632572565, 5060.2156665716875, 5198.882240318349, 5254.947450525522, 5287.788488460418, 5310.415854256029, 4052.858149964737, 4072.572379900127, 4099.8975025624, 4122.031322639177, 4155.563665815106, 1159.2175281684829, 1165.906727461801, 1166.393475392791, 1176.72346998457, 1188.4711303469874, 972.4116909269932, 1005.7686732051669, 1013.2755080117752, 1014.4471263161595, 1025.2157099818644, 6097.512199024068, 6113.205283313141, 6196.628202307876, 6223.0, 6225.968870155621, 636.7612145445459, 651.205529254309, 651.9185101862267, 665.7203974330793, 667.366002297819, 3854.5952674969285, 3875.2249550090096, 3910.530736311661, 3955.268275369066, 3975.2447035063824, 10540.525676344583, 10855.891441085647, 10908.472813806073, 10924.180686448548, 10939.343639381663, 10783.46082695862, 10806.94596527028, 10830.891691083147, 10837.512311945982, 10839.458027098772, 8144.633491492897, 8338.124496927856, 8416.705415310435, 8585.227329540496, 8586.184312490303, 6068.453839154321, 6320.683965801783, 6332.208473940757, 6346.111544383698, 6365.490760739037, 9591.232701384011, 9748.85376719364, 9872.45701486425, 9887.555060022172, 10059.0, 10100.898991009995, 10101.545430455793, 10152.54313555877, 10181.643642472478, 10202.489875506344, 7142.5000249982, 7936.047674279123, 7947.403944704055, 7981.321587665114, 8110.918890811016, 8750.781230469289, 8786.0, 8794.120587941155, 8817.867731983897, 8825.470471771458, 7654.15804261542, 7704.576248306397, 7706.537607743553, 7724.150343462327, 7750.10873749526, 7405.668857240024, 7443.3673137781725, 7467.141278752796, 7543.358814500829, 7629.618519074135, 6782.762603308861, 6795.490338224554, 6838.076859623887, 6875.48433867452, 6887.758928437481, 5265.262863199232, 5305.310309659874, 5387.461253874581, 5393.946060539502, 5397.676139431646, 5419.3225846769155, 5445.918311225256, 5479.068558345011, 5522.751476183662, 5538.723063846711], "value": 4701.50569029829, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.58867515497235, 418.2972606021882, 418.8492142828581, 427.9786010699464, 430.9138172365526, 5341.839744807662, 5511.311086114236, 5514.779408823642, 5570.637908535942, 5643.774249030039, 5323.148296272597, 5403.243545903577, 5492.80775172869, 5507.0, 5514.393416724157, 4186.874393768192, 4304.827806887721, 4308.190559964823, 4376.934345984812, 4384.364267181257, 4284.528701842794, 4301.2902871026245, 4308.0737641407095, 4308.362822127587, 4317.69776115672, 4266.807993640294, 4296.355546667994, 4303.396445150685, 4320.697551171419, 4373.016071383945, 4191.365367506675, 4294.549072347421, 4348.412964249817, 4354.303311470149, 4359.629431498311, 3810.580836108026, 3814.6757525610356, 3817.1983883384523, 3818.8281527331337, 3855.6529912307747, 5436.565074794007, 5438.456154384569, 5439.619226654136, 5472.5621950243885, 5490.231367608538, 4837.685550439211, 5001.574866136383, 5016.946441247343, 5040.9918016396505, 5055.9241611375855, 5740.138979153118, 5791.971040144815, 5797.826065218008, 5822.107814960155, 5826.242588463472, 4275.401443797839, 4282.721623094489, 4291.570842915715, 4298.46269216348, 4304.354346847967, 5828.6502809831545, 5993.011153159679, 6057.30341010785, 6095.207623009025, 6137.877242455171, 4292.720973136736, 4298.699091063658, 4341.088371442032, 4350.1294443389015, 4358.607725304674, 4414.205443020287, 4418.359337895987, 4419.160359531678, 4421.955780442155, 4432.977835110803, 4834.371531700856, 4942.233953737176, 4954.355933728664, 4964.925526117111, 4973.875653108629, 5738.282714660668, 5795.710214489259, 5796.88406231873, 5802.33273173582, 5808.157817116579, 1462.627030107316, 1466.142306750563, 1470.6176394137387, 1475.9335829887682, 1485.3883536363167, 970.1075010989906, 1005.416858222244, 1022.1311884897777, 1023.6232267600066, 1043.4939054558533, 5487.807926722546, 5498.422665620133, 5509.146082357241, 5523.364813046551, 5535.003699334158, 5750.971245143747, 5761.452661997104, 5762.74067666956, 5773.451522105393, 5795.768169273182, 5458.45415458459, 5526.4197259288, 5547.472990065938, 5577.24316840194, 5624.3813180550105, 3031.711522602885, 3089.2276930767307, 3089.6096756459233, 3097.566340712257, 3102.720755132049, 5855.707214639251, 5992.8801423972145, 6042.0967395270345, 6043.335233124353, 6054.485368743618, 5812.680302583399, 5856.355800861902, 5862.508433915569, 5899.351071382144, 5909.172715819789, 5977.551683623746, 6001.159837622737, 6006.609570377911, 6020.591763294629, 6027.21646185993, 5614.606977511535, 5620.189905047477, 5703.201551782837, 5733.627314224562, 5748.971255143698, 5631.902453650558, 5649.096144616841, 5650.717464126859, 5657.5473962082115, 5677.460641239076, 5947.762089516371, 5986.491148252448, 6121.969390153021, 6137.815865524041, 6178.938210617836, 4263.573642635712, 4324.56754324565, 4329.264025115801, 4334.393184954046, 4345.717528360647, 5765.365809760839, 5969.791057313147, 5984.371640977634, 5989.5507836913275, 6045.153678485103, 5774.797882074107, 5788.681622510634, 5795.420457954171, 5812.546863284179, 5813.186153938536, 5728.770849165987, 5806.912896306474, 5810.273715785527, 5811.854703632443, 5828.04760405269, 5570.220169176399, 5661.631993920382, 5714.942850571441, 5778.595498315078, 5786.33457152416, 5786.508146807569, 5790.276215473066, 5827.388124246893, 5874.823755287348, 5907.695998560651, 5565.248691426606, 5739.426057394227, 5762.415335782694, 5783.392743761844, 5792.333881603669], "value": 4442.394152027066, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [785.6739453126953, 805.8468890910726, 829.4774292195916, 924.6347692661399, 938.9014153513881, 16548.420805271817, 17643.47069587913, 17874.374396896095, 17991.100444977732, 17999.91000045001, 16639.584010399747, 16732.83267167328, 17302.56743581408, 17404.738928916075, 17956.461306160803, 814.5601375257354, 825.63671984327, 842.8735689646571, 843.4306842881061, 844.6494704697543, 824.9670013199465, 829.2246749289403, 830.9169083091703, 830.9376796740269, 831.1107115386538, 869.9391042627019, 872.1888643561485, 872.5855218771096, 876.1632640827994, 876.8334016536869, 872.4590753732695, 873.3449912565576, 874.45783614159, 875.1598465473154, 875.7197696737047, 639.5682914033056, 640.9775657852, 642.6272761798145, 643.9935600644027, 644.3202421445374, 16066.75899861503, 16178.35286588535, 16201.513954581382, 17840.107994600217, 17995.010274434902, 16030.919845400815, 16288.918555407146, 16335.101569413677, 16343.0, 16500.25748841293, 13418.329083545783, 13488.258145801978, 13578.185308881499, 13747.38136783847, 13825.446982120704, 3986.242613903349, 3987.1626958338784, 3988.8603898863403, 4006.859759908389, 4023.7988100595144, 79261.10180661346, 79462.20537794664, 80179.0, 80647.19352806456, 81053.0, 12444.564440244549, 12530.0, 12607.810882836582, 12641.494340226473, 12779.36103194855, 23544.64683029756, 23662.0, 23663.645045324334, 23669.408264793517, 23737.0, 8160.469569478084, 8265.868358761112, 8299.29455996235, 8307.83384332322, 8524.36067294943, 5065.493450654905, 5077.669951453144, 5089.134847076006, 5108.259302401206, 5110.66780659256, 3681.7422780405113, 3732.346839303111, 3738.1962877981364, 3792.6965842732516, 3795.203007368428, 563.1383982506771, 568.3634329550929, 571.7027145884117, 575.2406822993692, 578.9594728369058, 871.1288711288711, 883.4301875290402, 893.5041052215953, 896.3814967672286, 898.7124120281578, 11090.22368434218, 11413.714657133472, 11443.656690299138, 11584.652460426201, 11656.592019279455, 838.5094719588986, 842.8675303090955, 848.7708318753902, 872.991270087291, 878.0911756332293, 5210.53105220532, 5456.890862182813, 5497.147942068986, 5533.225348451139, 5538.556915446755, 80959.5952020248, 82161.0, 82257.17742822615, 84011.5799420999, 86902.0, 68341.65829170823, 69978.0, 71807.0, 72636.27363726294, 73505.26494734985, 63545.36454635487, 64298.67850660717, 64429.355706443275, 64470.35529644737, 65573.67213163999, 11552.364619945984, 12043.277403355476, 12170.939145304217, 12446.688832779253, 12448.937755311528, 36589.634103659686, 39562.0, 40928.79535602303, 41420.0, 42163.578364215966, 54607.453925460235, 54679.0, 56220.43779562152, 56339.43660563342, 56997.715011424676, 14164.220967846868, 14190.787138192729, 14199.0, 14206.928965355108, 14418.927905360406, 16102.516924492284, 16257.59356016109, 16408.753868692216, 16643.3342666292, 16831.070000644286, 15517.922410387875, 15594.37622495133, 15944.202789860228, 16162.67674646524, 16332.183390830649, 15074.472393466176, 15192.240387980777, 15289.847101528841, 15677.451289204822, 15961.680766384376, 15200.239988000776, 15249.161833321532, 15349.386024559339, 15372.615684607526, 15582.298796554409, 12533.623991280276, 13304.334783260992, 13409.195448272745, 13409.463621455032, 13524.391402387113, 12058.15592908488, 12098.274103553815, 12262.632121036384, 12301.384930753606, 12411.62765117048], "value": 7895.861868128762, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1481.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 116.0, 113.0, 112.0, 116.0, 113.0, 112.0, 113.0, 113.0, 119.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 120.0, 121.0, 165.0, 119.0, 117.0, 118.0, 119.0, 141.0, 121.0], "value": 128.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 164.0, 162.0, 162.0, 162.0, 161.0, 162.0, 161.0, 163.0, 161.0], "value": 161.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 77.0, 74.0, 115.0, 75.0, 75.0, 76.0, 76.0, 92.0, 76.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 100.0, 82.0, 83.0, 83.0, 98.0, 82.0, 82.0, 105.0], "value": 88.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 149.0, 149.0, 151.0, 148.0, 147.0, 148.0, 148.0, 150.0, 148.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 103.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0, 97.0, 96.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 54.0, 56.0, 55.0, 55.0, 54.0, 59.0, 55.0, 54.0], "value": 55.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 68.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 83.0, 75.0, 77.0, 77.0, 75.0, 75.0, 76.0, 80.0, 75.0], "value": 76.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 123.0, 121.0, 130.0, 120.0, 127.0, 122.0, 118.0, 164.0, 123.0], "value": 127.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 155.0, 157.0, 158.0, 165.0, 157.0, 158.0, 157.0, 155.0, 161.0], "value": 159.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 61.0, 68.0, 60.0, 61.0, 60.0, 61.0, 60.0, 61.0, 60.0], "value": 61.3, "unit": "score"}]}]} 20:06:03 INFO - Return code: 0 20:06:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:06:03 ERROR - # TBPL SUCCESS # 20:06:03 INFO - Running post-action listener: _resource_record_post_action 20:06:03 INFO - [mozharness: 2017-02-06 04:06:03.434255Z] Finished run-tests step (success) 20:06:03 INFO - Running post-run listener: _resource_record_post_run 20:06:03 INFO - Total resource usage - Wall time: 1190s; CPU: 13.0%; Read bytes: 4096; Write bytes: 360968192; Read time: 8; Write time: 499264 20:06:03 INFO - TinderboxPrint: CPU usage
13.3% 20:06:03 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 20:06:03 INFO - TinderboxPrint: I/O write bytes / time
360,968,192 / 499,264 20:06:03 INFO - TinderboxPrint: CPU idle
8,228.1 (86.7%) 20:06:03 INFO - TinderboxPrint: CPU user
1,208.3 (12.7%) 20:06:03 INFO - TinderboxPrint: Swap in / out
0 / 0 20:06:03 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 109387776; Read time: 0; Write time: 136584 20:06:03 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 4096; Write bytes: 251580416; Read time: 8; Write time: 362680 20:06:04 INFO - Running post-run listener: _upload_blobber_files 20:06:04 INFO - Blob upload gear active. 20:06:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:06:04 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 20:06:04 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-Aurora-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:06:04 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-Aurora-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:06:04 INFO - (blobuploader) - INFO - Open directory for files ... 20:06:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:06:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:06:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:06:05 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:06:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:06:05 INFO - (blobuploader) - INFO - Done attempting. 20:06:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:06:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:06:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:06:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:06:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:06:06 INFO - (blobuploader) - INFO - Done attempting. 20:06:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:06:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:06:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:06:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:06:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:06:07 INFO - (blobuploader) - INFO - Done attempting. 20:06:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:06:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:06:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:06:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:06:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:06:10 INFO - (blobuploader) - INFO - Done attempting. 20:06:10 INFO - (blobuploader) - INFO - Iteration through files over. 20:06:10 INFO - Return code: 0 20:06:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:06:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:06:10 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/71d46b0c19e80b089162de1a68701e175b1afbcbded8d97a0d209f098213c5408d2aee1669ab893d718d70ef518a1033ddc8d9cc645057d2dfa41c7d087631fc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/269774685766330036adf74475570f2705c2bad0748c39df3f1e87db07cdfa3b1b9b2413f12cac032af2a96bc7f294744f19fd56e9c23dfc1dce9913639c4bd7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3fd4db132514ad61ac85162d93880fcb01bd2a5465de5bd83a0bd0b621346d3ab266c7311b8993b9e609e7e90d523c2b9560d36990e26abeb59599c2b05aea8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/feaa45b98edbd367c7f3ebf4a85dbb21db6438b2ba7936b6eddb0be516839cf3b2c335abdca9845d0404c6da2ddd5e734aa52c87bcc666c2dcdd3efcd9d82f2c"} 20:06:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:06:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:06:10 INFO - Contents: 20:06:10 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/71d46b0c19e80b089162de1a68701e175b1afbcbded8d97a0d209f098213c5408d2aee1669ab893d718d70ef518a1033ddc8d9cc645057d2dfa41c7d087631fc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/269774685766330036adf74475570f2705c2bad0748c39df3f1e87db07cdfa3b1b9b2413f12cac032af2a96bc7f294744f19fd56e9c23dfc1dce9913639c4bd7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3fd4db132514ad61ac85162d93880fcb01bd2a5465de5bd83a0bd0b621346d3ab266c7311b8993b9e609e7e90d523c2b9560d36990e26abeb59599c2b05aea8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/feaa45b98edbd367c7f3ebf4a85dbb21db6438b2ba7936b6eddb0be516839cf3b2c335abdca9845d0404c6da2ddd5e734aa52c87bcc666c2dcdd3efcd9d82f2c"} 20:06:10 INFO - Running post-run listener: copy_logs_to_upload_dir 20:06:10 INFO - Copying logs to upload dir... 20:06:10 INFO - mkdir: /builds/slave/test/build/upload/logs 20:06:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.040056 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-05 20:06:09.997633) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-05 20:06:10.001012) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/71d46b0c19e80b089162de1a68701e175b1afbcbded8d97a0d209f098213c5408d2aee1669ab893d718d70ef518a1033ddc8d9cc645057d2dfa41c7d087631fc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/269774685766330036adf74475570f2705c2bad0748c39df3f1e87db07cdfa3b1b9b2413f12cac032af2a96bc7f294744f19fd56e9c23dfc1dce9913639c4bd7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3fd4db132514ad61ac85162d93880fcb01bd2a5465de5bd83a0bd0b621346d3ab266c7311b8993b9e609e7e90d523c2b9560d36990e26abeb59599c2b05aea8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/feaa45b98edbd367c7f3ebf4a85dbb21db6438b2ba7936b6eddb0be516839cf3b2c335abdca9845d0404c6da2ddd5e734aa52c87bcc666c2dcdd3efcd9d82f2c"} build_url:https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011473 build_url: 'https://queue.taskcluster.net/v1/task/Ec9SgxE9RTuHf4JZE_3-bQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/71d46b0c19e80b089162de1a68701e175b1afbcbded8d97a0d209f098213c5408d2aee1669ab893d718d70ef518a1033ddc8d9cc645057d2dfa41c7d087631fc", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/269774685766330036adf74475570f2705c2bad0748c39df3f1e87db07cdfa3b1b9b2413f12cac032af2a96bc7f294744f19fd56e9c23dfc1dce9913639c4bd7", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/3fd4db132514ad61ac85162d93880fcb01bd2a5465de5bd83a0bd0b621346d3ab266c7311b8993b9e609e7e90d523c2b9560d36990e26abeb59599c2b05aea8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/feaa45b98edbd367c7f3ebf4a85dbb21db6438b2ba7936b6eddb0be516839cf3b2c335abdca9845d0404c6da2ddd5e734aa52c87bcc666c2dcdd3efcd9d82f2c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-05 20:06:10.025639) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 20:06:10.025948) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ba164b0a7b0ec7655860e956000001c1-1486352727.498193-2059046926 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004490 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-05 20:06:10.111452) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-05 20:06:10.111779) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-05 20:06:10.112063) ========= ========= Total master_lag: 0.17 =========