builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-050 starttime: 1486689916.79 results: success (0) revision: 63752d3df9fa09ecd3283eaccb950cc5607fbab1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 17:25:16.792989) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 17:25:16.793537) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 17:25:16.793879) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 17:25:16.810424) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 17:25:16.810770) ========= 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=6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-09 17:25:16-- 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% 42.9M=0s 2017-02-09 17:25:16 (42.9 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.118932 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 17:25:16.943820) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 17:25:16.944180) ========= 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=6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019373 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 17:25:16.994836) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 17:25:16.995326) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 63752d3df9fa09ecd3283eaccb950cc5607fbab1 --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 63752d3df9fa09ecd3283eaccb950cc5607fbab1 --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=6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-09 17:25:17,066 truncating revision to first 12 chars 2017-02-09 17:25:17,066 Setting DEBUG logging. 2017-02-09 17:25:17,067 attempt 1/10 2017-02-09 17:25:17,067 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/63752d3df9fa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 17:25:18,398 unpacking tar archive at: mozilla-aurora-63752d3df9fa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.624182 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 17:25:18.633009) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 17:25:18.633376) ========= script_repo_revision: 63752d3df9fa09ecd3283eaccb950cc5607fbab1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 17:25:18.633825) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 17:25:18.634198) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 17:25:18.643074) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-09 17:25:18.643398) ========= /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=6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:25:18 INFO - MultiFileLogger online at 20170209 17:25:18 in /builds/slave/test 17:25:18 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 17:25:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:25:18 INFO - {'append_to_log': False, 17:25:18 INFO - 'base_work_dir': '/builds/slave/test', 17:25:18 INFO - 'blob_upload_branch': 'Mozilla-Aurora-Non-PGO', 17:25:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:25:18 INFO - 'branch': 'Mozilla-Aurora-Non-PGO', 17:25:18 INFO - 'buildbot_json_path': 'buildprops.json', 17:25:18 INFO - 'config_files': ('talos/linux_config.py',), 17:25:18 INFO - 'default_actions': ('clobber', 17:25:18 INFO - 'read-buildbot-config', 17:25:18 INFO - 'download-and-extract', 17:25:18 INFO - 'populate-webroot', 17:25:18 INFO - 'create-virtualenv', 17:25:18 INFO - 'install', 17:25:18 INFO - 'run-tests'), 17:25:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:25:18 INFO - 'download_minidump_stackwalk': True, 17:25:18 INFO - 'download_symbols': 'ondemand', 17:25:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:25:18 INFO - 'tooltool.py': '/tools/tooltool.py', 17:25:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:25:18 INFO - '/tools/misc-python/virtualenv.py')}, 17:25:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:25:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:25:18 INFO - 'installer_path': 'installer.exe', 17:25:18 INFO - 'log_level': 'info', 17:25:18 INFO - 'log_name': 'talos', 17:25:18 INFO - 'log_to_console': True, 17:25:18 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:25:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:25:18 INFO - 'opt_config_files': (), 17:25:18 INFO - 'pip_index': False, 17:25:18 INFO - 'sps_profile': False, 17:25:18 INFO - 'sps_profile_interval': 0, 17:25:18 INFO - 'suite': 'dromaeojs-e10s', 17:25:18 INFO - 'system_bits': '32', 17:25:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:25:18 INFO - 'title': 'talos-linux64-ix-050', 17:25:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:25:18 INFO - 'use_talos_json': True, 17:25:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:25:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:25:18 INFO - 'work_dir': 'build'} 17:25:18 INFO - [mozharness: 2017-02-10 01:25:18.811823Z] Running clobber step. 17:25:18 INFO - Running pre-action listener: _resource_record_pre_action 17:25:18 INFO - Running main action method: clobber 17:25:18 INFO - rmtree: /builds/slave/test/build 17:25:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:25:19 INFO - Running post-action listener: _resource_record_post_action 17:25:19 INFO - [mozharness: 2017-02-10 01:25:19.310023Z] Finished clobber step (success) 17:25:19 INFO - [mozharness: 2017-02-10 01:25:19.310124Z] Running read-buildbot-config step. 17:25:19 INFO - Running pre-action listener: _resource_record_pre_action 17:25:19 INFO - Running main action method: read_buildbot_config 17:25:19 INFO - Using buildbot properties: 17:25:19 INFO - { 17:25:19 INFO - "project": "", 17:25:19 INFO - "product": "firefox", 17:25:19 INFO - "who": "ryanvm@gmail.com", 17:25:19 INFO - "installer_path": "public/build/target.tar.bz2", 17:25:19 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs-e10s", 17:25:19 INFO - "repository": "https://hg.mozilla.org/releases/mozilla-aurora/", 17:25:19 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora talos dromaeojs-e10s", 17:25:19 INFO - "stage_platform": "linux64", 17:25:19 INFO - "basedir": "/builds/slave/test", 17:25:19 INFO - "buildnumber": 26, 17:25:19 INFO - "platform": "ubuntu64_hw", 17:25:19 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 17:25:19 INFO - "slavebuilddir": "test", 17:25:19 INFO - "taskId": "e5YYJNPOQ8qDc041xh8yEw", 17:25:19 INFO - "branch": "mozilla-aurora", 17:25:19 INFO - "script_repo_revision": "production", 17:25:19 INFO - "revision": "63752d3df9fa09ecd3283eaccb950cc5607fbab1", 17:25:19 INFO - "slavename": "talos-linux64-ix-050", 17:25:19 INFO - "repo_path": "releases/mozilla-aurora" 17:25:19 INFO - } 17:25:19 INFO - Finding installer, test and symbols from parent task. 17:25:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e5YYJNPOQ8qDc041xh8yEw'}, attempt #1 17:25:19 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/e5YYJNPOQ8qDc041xh8yEw'}, attempt #1 17:25:20 INFO - Task dependencies: Tn4IGwBxS7669Hnno10MvQ 17:25:20 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tn4IGwBxS7669Hnno10MvQ'}, attempt #1 17:25:20 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Tn4IGwBxS7669Hnno10MvQ/artifacts/public/build/target.tar.bz2 17:25:20 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Tn4IGwBxS7669Hnno10MvQ/artifacts/public/build/test_packages.json 17:25:20 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Tn4IGwBxS7669Hnno10MvQ/artifacts/public/build/target.crashreporter-symbols.zip 17:25:20 INFO - Running post-action listener: _resource_record_post_action 17:25:20 INFO - [mozharness: 2017-02-10 01:25:20.726069Z] Finished read-buildbot-config step (success) 17:25:20 INFO - [mozharness: 2017-02-10 01:25:20.726287Z] Running download-and-extract step. 17:25:20 INFO - Running pre-action listener: _resource_record_pre_action 17:25:20 INFO - Running main action method: download_and_extract 17:25:20 INFO - mkdir: /builds/slave/test/build/tests 17:25:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:20 INFO - trying https://queue.taskcluster.net/v1/task/Tn4IGwBxS7669Hnno10MvQ/artifacts/public/build/target.test_packages.json 17:25:20 INFO - Downloading https://queue.taskcluster.net/v1/task/Tn4IGwBxS7669Hnno10MvQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 17:25:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tn4IGwBxS7669Hnno10MvQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 17:25:21 INFO - Downloaded 896 bytes. 17:25:21 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 17:25:21 INFO - Using the following test package requirements: 17:25:21 INFO - {u'common': [u'target.common.tests.zip'], 17:25:21 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 17:25:21 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 17:25:21 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 17:25:21 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 17:25:21 INFO - u'mozbase': [u'target.common.tests.zip'], 17:25:21 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 17:25:21 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 17:25:21 INFO - u'web-platform': [u'target.common.tests.zip', 17:25:21 INFO - u'target.web-platform.tests.zip'], 17:25:21 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 17:25:21 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 17:25:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tn4IGwBxS7669Hnno10MvQ/artifacts/public/build/target.common.tests.zip 17:25:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tn4IGwBxS7669Hnno10MvQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:25:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Tn4IGwBxS7669Hnno10MvQ/artifacts/public/build/target.common.tests.zip into memory 17:25:22 INFO - Expected file size: 21858269 17:25:22 INFO - Obtained file size: 21858269 17:25:26 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 17:25:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tn4IGwBxS7669Hnno10MvQ/artifacts/public/build/target.common.tests.zip 17:25:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tn4IGwBxS7669Hnno10MvQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 17:25:26 INFO - Fetch https://queue.taskcluster.net/v1/task/Tn4IGwBxS7669Hnno10MvQ/artifacts/public/build/target.common.tests.zip into memory 17:25:26 INFO - Expected file size: 21858269 17:25:26 INFO - Obtained file size: 21858269 17:25:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Tn4IGwBxS7669Hnno10MvQ/artifacts/public/build/target.talos.tests.zip 17:25:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Tn4IGwBxS7669Hnno10MvQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 17:25:31 INFO - Fetch https://queue.taskcluster.net/v1/task/Tn4IGwBxS7669Hnno10MvQ/artifacts/public/build/target.talos.tests.zip into memory 17:25:32 INFO - Expected file size: 14403485 17:25:32 INFO - Obtained file size: 14403485 17:25:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:32 INFO - trying https://queue.taskcluster.net/v1/task/Tn4IGwBxS7669Hnno10MvQ/artifacts/public/build/target.tar.bz2 17:25:32 INFO - Downloading https://queue.taskcluster.net/v1/task/Tn4IGwBxS7669Hnno10MvQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 17:25:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Tn4IGwBxS7669Hnno10MvQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 17:25:33 INFO - Downloaded 66050631 bytes. 17:25:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Tn4IGwBxS7669Hnno10MvQ/artifacts/public/build/target.tar.bz2 17:25:33 INFO - mkdir: /builds/slave/test/properties 17:25:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:25:33 INFO - Writing to file /builds/slave/test/properties/build_url 17:25:33 INFO - Contents: 17:25:33 INFO - build_url:https://queue.taskcluster.net/v1/task/Tn4IGwBxS7669Hnno10MvQ/artifacts/public/build/target.tar.bz2 17:25:33 INFO - Running post-action listener: _resource_record_post_action 17:25:33 INFO - Running post-action listener: set_extra_try_arguments 17:25:33 INFO - [mozharness: 2017-02-10 01:25:33.568053Z] Finished download-and-extract step (success) 17:25:33 INFO - [mozharness: 2017-02-10 01:25:33.568149Z] Running populate-webroot step. 17:25:33 INFO - Running pre-action listener: _resource_record_pre_action 17:25:33 INFO - Running main action method: populate_webroot 17:25:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:25:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:25:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:25:33 INFO - '--tppagecycles', 17:25:33 INFO - '7'], 17:25:33 INFO - 'tests': ['tsvgm']}}, 17:25:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:25:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:25:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:25:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:25:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:25:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:25:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:25:33 INFO - 'talos_options': ['--disable-e10s'], 17:25:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:25:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:25:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:25:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:25:33 INFO - 'talos_options': ['--disable-e10s'], 17:25:33 INFO - 'tests': ['damp', 'tps']}, 17:25:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:25:33 INFO - 'tests': ['damp', 'tps']}, 17:25:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:25:33 INFO - 'tests': ['dromaeo_dom']}, 17:25:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:25:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:25:33 INFO - 'tests': ['basic_compositor_video']}, 17:25:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:25:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:25:33 INFO - 'tests': ['a11yr', 17:25:33 INFO - 'ts_paint', 17:25:33 INFO - 'tpaint', 17:25:33 INFO - 'sessionrestore', 17:25:33 INFO - 'sessionrestore_no_auto_restore', 17:25:33 INFO - 'tabpaint']}, 17:25:33 INFO - 'other-e10s': {'tests': ['a11yr', 17:25:33 INFO - 'ts_paint', 17:25:33 INFO - 'tpaint', 17:25:33 INFO - 'sessionrestore', 17:25:33 INFO - 'sessionrestore_no_auto_restore', 17:25:33 INFO - 'tabpaint']}, 17:25:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:25:33 INFO - 'ts_paint', 17:25:33 INFO - 'tpaint', 17:25:33 INFO - 'sessionrestore', 17:25:33 INFO - 'sessionrestore_no_auto_restore', 17:25:33 INFO - 'tabpaint']}, 17:25:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:25:33 INFO - 'ts_paint', 17:25:33 INFO - 'tpaint', 17:25:33 INFO - 'sessionrestore', 17:25:33 INFO - 'sessionrestore_no_auto_restore', 17:25:33 INFO - 'tabpaint']}, 17:25:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:25:33 INFO - 'tests': ['a11yr', 17:25:33 INFO - 'ts_paint', 17:25:33 INFO - 'tpaint', 17:25:33 INFO - 'sessionrestore', 17:25:33 INFO - 'sessionrestore_no_auto_restore', 17:25:33 INFO - 'tabpaint']}, 17:25:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:25:33 INFO - 'tests': ['a11yr', 17:25:33 INFO - 'ts_paint', 17:25:33 INFO - 'tpaint', 17:25:33 INFO - 'sessionrestore', 17:25:33 INFO - 'sessionrestore_no_auto_restore', 17:25:33 INFO - 'tabpaint']}, 17:25:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:25:33 INFO - 'tests': ['tsvgx', 17:25:33 INFO - 'tsvgr_opacity', 17:25:33 INFO - 'tart', 17:25:33 INFO - 'tscrollx', 17:25:33 INFO - 'cart', 17:25:33 INFO - 'tsvg_static']}, 17:25:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:25:33 INFO - 'tsvgr_opacity', 17:25:33 INFO - 'tart', 17:25:33 INFO - 'tscrollx', 17:25:33 INFO - 'cart', 17:25:33 INFO - 'tsvg_static']}, 17:25:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:25:33 INFO - 'talos_options': ['--disable-e10s'], 17:25:33 INFO - 'tests': ['tp5o']}, 17:25:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:25:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:25:33 INFO - 'talos_options': ['--disable-e10s', 17:25:33 INFO - '--xperf_path', 17:25:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:25:33 INFO - 'tests': ['tp5n']}, 17:25:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:25:33 INFO - 'talos_options': ['--xperf_path', 17:25:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:25:33 INFO - 'tests': ['tp5n']}}, 17:25:33 INFO - 'talos.zip': {'path': '', 17:25:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:25:33 INFO - Running post-action listener: _resource_record_post_action 17:25:33 INFO - [mozharness: 2017-02-10 01:25:33.581159Z] Finished populate-webroot step (success) 17:25:33 INFO - [mozharness: 2017-02-10 01:25:33.581250Z] Running create-virtualenv step. 17:25:33 INFO - Running pre-action listener: _resource_record_pre_action 17:25:33 INFO - Running main action method: create_virtualenv 17:25:33 INFO - Creating virtualenv /builds/slave/test/build/venv 17:25:33 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 17:25:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:25:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:25:33 INFO - Using real prefix '/usr' 17:25:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:25:34 INFO - Installing distribute.............................................................................................................................................................................................done. 17:25:36 INFO - Installing pip.................done. 17:25:36 INFO - Return code: 0 17:25:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:25:36 INFO - Reading from file tmpfile_stdout 17:25:36 INFO - Output received: 17:25:36 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) 17:25:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:25: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')]} 17:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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')]} 17:25:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a5980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a2d00>, '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 0x18a3a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a3eb0>, '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': '6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637', '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 17:25:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:25:36 INFO - Using env: {'DISPLAY': ':0', 17:25:36 INFO - 'HOME': '/home/cltbld', 17:25:36 INFO - 'LANG': 'en_US.UTF-8', 17:25:36 INFO - 'LANGUAGE': 'en_US:en', 17:25:36 INFO - 'LOGNAME': 'cltbld', 17:25:36 INFO - 'MAIL': '/var/mail/cltbld', 17:25:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:36 INFO - 'MOZ_NO_REMOTE': '1', 17:25:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:36 INFO - 'NO_EM_RESTART': '1', 17:25:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:36 INFO - 'PWD': '/builds/slave/test', 17:25:36 INFO - 'SHELL': '/bin/bash', 17:25:36 INFO - 'SHLVL': '1', 17:25:36 INFO - 'TERM': 'linux', 17:25:36 INFO - 'TMOUT': '86400', 17:25:36 INFO - 'USER': 'cltbld', 17:25:36 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637', 17:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:36 INFO - '_': '/tools/buildbot/bin/python'} 17:25:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:36 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 17:25:36 INFO - Cleaning up... 17:25:36 INFO - Return code: 0 17:25:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:25: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')]} 17:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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')]} 17:25:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a5980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a2d00>, '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 0x18a3a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a3eb0>, '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': '6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637', '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 17:25:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:25:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:25:36 INFO - Using env: {'DISPLAY': ':0', 17:25:36 INFO - 'HOME': '/home/cltbld', 17:25:36 INFO - 'LANG': 'en_US.UTF-8', 17:25:36 INFO - 'LANGUAGE': 'en_US:en', 17:25:36 INFO - 'LOGNAME': 'cltbld', 17:25:36 INFO - 'MAIL': '/var/mail/cltbld', 17:25:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:36 INFO - 'MOZ_NO_REMOTE': '1', 17:25:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:36 INFO - 'NO_EM_RESTART': '1', 17:25:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:36 INFO - 'PWD': '/builds/slave/test', 17:25:36 INFO - 'SHELL': '/bin/bash', 17:25:36 INFO - 'SHLVL': '1', 17:25:36 INFO - 'TERM': 'linux', 17:25:36 INFO - 'TMOUT': '86400', 17:25:36 INFO - 'USER': 'cltbld', 17:25:36 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637', 17:25:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:36 INFO - '_': '/tools/buildbot/bin/python'} 17:25:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:36 INFO - Downloading/unpacking psutil>=3.1.1 17:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:25:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:25:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:25:38 INFO - Installing collected packages: psutil 17:25:38 INFO - Running setup.py install for psutil 17:25:39 INFO - building 'psutil._psutil_linux' extension 17:25:39 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 17:25:39 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 17:25:39 INFO - building 'psutil._psutil_posix' extension 17:25:39 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 17:25:39 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 17:25:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:25:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:25:39 INFO - Successfully installed psutil 17:25:39 INFO - Cleaning up... 17:25:39 INFO - Return code: 0 17:25:39 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a5980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a2d00>, '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 0x18a3a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a3eb0>, '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': '6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637', '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 17:25:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:25:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:25:39 INFO - Using env: {'DISPLAY': ':0', 17:25:39 INFO - 'HOME': '/home/cltbld', 17:25:39 INFO - 'LANG': 'en_US.UTF-8', 17:25:39 INFO - 'LANGUAGE': 'en_US:en', 17:25:39 INFO - 'LOGNAME': 'cltbld', 17:25:39 INFO - 'MAIL': '/var/mail/cltbld', 17:25:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:39 INFO - 'MOZ_NO_REMOTE': '1', 17:25:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:39 INFO - 'NO_EM_RESTART': '1', 17:25:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:39 INFO - 'PWD': '/builds/slave/test', 17:25:39 INFO - 'SHELL': '/bin/bash', 17:25:39 INFO - 'SHLVL': '1', 17:25:39 INFO - 'TERM': 'linux', 17:25:39 INFO - 'TMOUT': '86400', 17:25:39 INFO - 'USER': 'cltbld', 17:25:39 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637', 17:25:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:39 INFO - '_': '/tools/buildbot/bin/python'} 17:25:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:25:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:25:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:25:41 INFO - Installing collected packages: mozsystemmonitor 17:25:41 INFO - Running setup.py install for mozsystemmonitor 17:25:41 INFO - Successfully installed mozsystemmonitor 17:25:41 INFO - Cleaning up... 17:25:41 INFO - Return code: 0 17:25:41 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a5980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a2d00>, '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 0x18a3a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a3eb0>, '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': '6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637', '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 17:25:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:25:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:25:41 INFO - Using env: {'DISPLAY': ':0', 17:25:41 INFO - 'HOME': '/home/cltbld', 17:25:41 INFO - 'LANG': 'en_US.UTF-8', 17:25:41 INFO - 'LANGUAGE': 'en_US:en', 17:25:41 INFO - 'LOGNAME': 'cltbld', 17:25:41 INFO - 'MAIL': '/var/mail/cltbld', 17:25:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:41 INFO - 'MOZ_NO_REMOTE': '1', 17:25:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:41 INFO - 'NO_EM_RESTART': '1', 17:25:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:41 INFO - 'PWD': '/builds/slave/test', 17:25:41 INFO - 'SHELL': '/bin/bash', 17:25:41 INFO - 'SHLVL': '1', 17:25:41 INFO - 'TERM': 'linux', 17:25:41 INFO - 'TMOUT': '86400', 17:25:41 INFO - 'USER': 'cltbld', 17:25:41 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637', 17:25:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:41 INFO - '_': '/tools/buildbot/bin/python'} 17:25:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:42 INFO - Downloading/unpacking jsonschema==2.5.1 17:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:25:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:25:44 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 17:25:44 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 17:25:44 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 17:25:44 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 17:25:44 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 17:25:44 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 17:25:44 INFO - Downloading functools32-3.2.3-2.tar.gz 17:25:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:25:44 INFO - warning: no files found matching '*.txt' 17:25:44 INFO - no previously-included directories found matching 'build' 17:25:44 INFO - no previously-included directories found matching 'dist' 17:25:44 INFO - no previously-included directories found matching '.git*' 17:25:44 INFO - Installing collected packages: jsonschema, functools32 17:25:44 INFO - Running setup.py install for functools32 17:25:44 INFO - warning: no files found matching '*.txt' 17:25:44 INFO - no previously-included directories found matching 'build' 17:25:44 INFO - no previously-included directories found matching 'dist' 17:25:44 INFO - no previously-included directories found matching '.git*' 17:25:44 INFO - Successfully installed jsonschema functools32 17:25:44 INFO - Cleaning up... 17:25:44 INFO - Return code: 0 17:25:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x15331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a5980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a2d00>, '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 0x18a3a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a3eb0>, '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': '6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637', '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 17:25:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:25:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:25:44 INFO - Using env: {'DISPLAY': ':0', 17:25:44 INFO - 'HOME': '/home/cltbld', 17:25:44 INFO - 'LANG': 'en_US.UTF-8', 17:25:44 INFO - 'LANGUAGE': 'en_US:en', 17:25:44 INFO - 'LOGNAME': 'cltbld', 17:25:44 INFO - 'MAIL': '/var/mail/cltbld', 17:25:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:44 INFO - 'MOZ_NO_REMOTE': '1', 17:25:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:44 INFO - 'NO_EM_RESTART': '1', 17:25:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:44 INFO - 'PWD': '/builds/slave/test', 17:25:44 INFO - 'SHELL': '/bin/bash', 17:25:44 INFO - 'SHLVL': '1', 17:25:44 INFO - 'TERM': 'linux', 17:25:44 INFO - 'TMOUT': '86400', 17:25:44 INFO - 'USER': 'cltbld', 17:25:44 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637', 17:25:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:44 INFO - '_': '/tools/buildbot/bin/python'} 17:25:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:44 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:25:44 INFO - Cleaning up... 17:25:44 INFO - Return code: 0 17:25:44 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:45 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')]} 17:25:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:45 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 0x15331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a5980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a2d00>, '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 0x18a3a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a3eb0>, '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': '6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637', '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 17:25:45 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 17:25:45 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 17:25:45 INFO - Using env: {'DISPLAY': ':0', 17:25:45 INFO - 'HOME': '/home/cltbld', 17:25:45 INFO - 'LANG': 'en_US.UTF-8', 17:25:45 INFO - 'LANGUAGE': 'en_US:en', 17:25:45 INFO - 'LOGNAME': 'cltbld', 17:25:45 INFO - 'MAIL': '/var/mail/cltbld', 17:25:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:45 INFO - 'MOZ_NO_REMOTE': '1', 17:25:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:45 INFO - 'NO_EM_RESTART': '1', 17:25:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:45 INFO - 'PWD': '/builds/slave/test', 17:25:45 INFO - 'SHELL': '/bin/bash', 17:25:45 INFO - 'SHLVL': '1', 17:25:45 INFO - 'TERM': 'linux', 17:25:45 INFO - 'TMOUT': '86400', 17:25:45 INFO - 'USER': 'cltbld', 17:25:45 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637', 17:25:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:45 INFO - '_': '/tools/buildbot/bin/python'} 17:25:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:45 INFO - Downloading/unpacking blobuploader==1.2.4 17:25:45 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 17:25:45 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 17:25:45 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 17:25:45 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 17:25:45 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 17:25:45 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 17:25:47 INFO - Downloading blobuploader-1.2.4.tar.gz 17:25:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:25:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:25:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:48 INFO - Downloading docopt-0.6.1.tar.gz 17:25:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:25:48 INFO - Installing collected packages: blobuploader, requests, docopt 17:25:48 INFO - Running setup.py install for blobuploader 17:25:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:25:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:25:48 INFO - Running setup.py install for requests 17:25:48 INFO - Running setup.py install for docopt 17:25:48 INFO - Successfully installed blobuploader requests docopt 17:25:48 INFO - Cleaning up... 17:25:48 INFO - Return code: 0 17:25:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:25: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')]} 17:25:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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')]} 17:25:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:48 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 0x15331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a5980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a2d00>, '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 0x18a3a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a3eb0>, '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': '6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637', '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 17:25:48 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 17:25:48 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 17:25:48 INFO - Using env: {'DISPLAY': ':0', 17:25:48 INFO - 'HOME': '/home/cltbld', 17:25:48 INFO - 'LANG': 'en_US.UTF-8', 17:25:48 INFO - 'LANGUAGE': 'en_US:en', 17:25:48 INFO - 'LOGNAME': 'cltbld', 17:25:48 INFO - 'MAIL': '/var/mail/cltbld', 17:25:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:48 INFO - 'MOZ_NO_REMOTE': '1', 17:25:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:48 INFO - 'NO_EM_RESTART': '1', 17:25:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:48 INFO - 'PWD': '/builds/slave/test', 17:25:48 INFO - 'SHELL': '/bin/bash', 17:25:48 INFO - 'SHLVL': '1', 17:25:48 INFO - 'TERM': 'linux', 17:25:48 INFO - 'TMOUT': '86400', 17:25:48 INFO - 'USER': 'cltbld', 17:25:48 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637', 17:25:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:48 INFO - '_': '/tools/buildbot/bin/python'} 17:25:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:25:49 INFO - Running setup.py (path:/tmp/pip-212X03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:25:49 INFO - Running setup.py (path:/tmp/pip-LySou5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:25:49 INFO - Running setup.py (path:/tmp/pip-1A79Yt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:25:49 INFO - Running setup.py (path:/tmp/pip-q65NVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:25:49 INFO - Running setup.py (path:/tmp/pip-eMoevg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:25:49 INFO - Running setup.py (path:/tmp/pip-WKso_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:25:49 INFO - Running setup.py (path:/tmp/pip-ZHlSrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:25:49 INFO - Running setup.py (path:/tmp/pip-X9tQYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:25:49 INFO - Running setup.py (path:/tmp/pip-JkW6Rd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:25:49 INFO - Running setup.py (path:/tmp/pip-Cocl8R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:25:49 INFO - Running setup.py (path:/tmp/pip-p4geKh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:25:49 INFO - Running setup.py (path:/tmp/pip-y1m3Tr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:25:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:25:49 INFO - Running setup.py (path:/tmp/pip-nbPmC3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:25:50 INFO - Running setup.py (path:/tmp/pip-k5Fqje-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:50 INFO - Running setup.py (path:/tmp/pip-EPbf2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:25:50 INFO - Running setup.py (path:/tmp/pip-cYghAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:25:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:25:50 INFO - Running setup.py (path:/tmp/pip-mp3j5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:25:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:25:50 INFO - Running setup.py install for manifestparser 17:25:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:25:50 INFO - Running setup.py install for mozcrash 17:25:50 INFO - Running setup.py install for mozdebug 17:25:50 INFO - Running setup.py install for mozdevice 17:25:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:25:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:25:50 INFO - Running setup.py install for mozfile 17:25:50 INFO - Running setup.py install for mozhttpd 17:25:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:25:50 INFO - Running setup.py install for mozinfo 17:25:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:25:51 INFO - Running setup.py install for mozInstall 17:25:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:25:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:25:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:25:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:25:51 INFO - Running setup.py install for mozleak 17:25:51 INFO - Running setup.py install for mozlog 17:25:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:25:51 INFO - Running setup.py install for moznetwork 17:25:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:25:51 INFO - Running setup.py install for mozprocess 17:25:51 INFO - Running setup.py install for mozprofile 17:25:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:25:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:25:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:25:51 INFO - Running setup.py install for mozrunner 17:25:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:25:51 INFO - Running setup.py install for mozscreenshot 17:25:51 INFO - Running setup.py install for moztest 17:25:52 INFO - Running setup.py install for mozversion 17:25:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:25:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:25:52 INFO - Cleaning up... 17:25:52 INFO - Return code: 0 17:25:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:25: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')]} 17:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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')]} 17:25:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:52 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 0x15331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a5980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a2d00>, '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 0x18a3a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a3eb0>, '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': '6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637', '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 17:25:52 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 17:25:52 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 17:25:52 INFO - Using env: {'DISPLAY': ':0', 17:25:52 INFO - 'HOME': '/home/cltbld', 17:25:52 INFO - 'LANG': 'en_US.UTF-8', 17:25:52 INFO - 'LANGUAGE': 'en_US:en', 17:25:52 INFO - 'LOGNAME': 'cltbld', 17:25:52 INFO - 'MAIL': '/var/mail/cltbld', 17:25:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:52 INFO - 'MOZ_NO_REMOTE': '1', 17:25:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:52 INFO - 'NO_EM_RESTART': '1', 17:25:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:52 INFO - 'PWD': '/builds/slave/test', 17:25:52 INFO - 'SHELL': '/bin/bash', 17:25:52 INFO - 'SHLVL': '1', 17:25:52 INFO - 'TERM': 'linux', 17:25:52 INFO - 'TMOUT': '86400', 17:25:52 INFO - 'USER': 'cltbld', 17:25:52 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637', 17:25:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:52 INFO - '_': '/tools/buildbot/bin/python'} 17:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:25:52 INFO - Running setup.py (path:/tmp/pip-Bn4WB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:25:52 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)) 17:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:25:52 INFO - Running setup.py (path:/tmp/pip-hr7GgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:25:52 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)) 17:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:25:52 INFO - Running setup.py (path:/tmp/pip-BKmZTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:25:52 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)) 17:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:25:52 INFO - Running setup.py (path:/tmp/pip-NTx9pJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:25:52 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)) 17:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:25:52 INFO - Running setup.py (path:/tmp/pip-cfijGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:25:52 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)) 17:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:25:52 INFO - Running setup.py (path:/tmp/pip-FViHzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:25:52 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)) 17:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:25:52 INFO - Running setup.py (path:/tmp/pip-85ZgOG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:25:52 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)) 17:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:25:52 INFO - Running setup.py (path:/tmp/pip-USc9lL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:25:52 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)) 17:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:25:52 INFO - Running setup.py (path:/tmp/pip-p6S_fB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:25:52 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)) 17:25:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:25:53 INFO - Running setup.py (path:/tmp/pip-Ltt1RZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:25:53 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)) 17:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:25:53 INFO - Running setup.py (path:/tmp/pip-6Gk5Ob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:25:53 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)) 17:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:25:53 INFO - Running setup.py (path:/tmp/pip-KOXrND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:25:53 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)) 17:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:25:53 INFO - Running setup.py (path:/tmp/pip-1qzmb0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:25:53 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)) 17:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:25:53 INFO - Running setup.py (path:/tmp/pip-SmadM6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:25:53 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)) 17:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:53 INFO - Running setup.py (path:/tmp/pip-2A31XW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:53 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)) 17:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:25:53 INFO - Running setup.py (path:/tmp/pip-NguSNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:25:53 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)) 17:25:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:25:53 INFO - Running setup.py (path:/tmp/pip-exUElo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:25:53 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)) 17:25:53 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)) 17:25:53 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)) 17:25:53 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)) 17:25:53 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)) 17:25:53 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)) 17:25:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:25:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:25:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:25:55 INFO - Downloading blessings-1.6.tar.gz 17:25:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:25:55 INFO - Installing collected packages: blessings 17:25:55 INFO - Running setup.py install for blessings 17:25:55 INFO - Successfully installed blessings 17:25:55 INFO - Cleaning up... 17:25:55 INFO - Return code: 0 17:25:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:25:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:25:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:25:56 INFO - Reading from file tmpfile_stdout 17:25:56 INFO - Current package versions: 17:25:56 INFO - argparse == 1.2.1 17:25:56 INFO - blessings == 1.6 17:25:56 INFO - blobuploader == 1.2.4 17:25:56 INFO - docopt == 0.6.1 17:25:56 INFO - functools32 == 3.2.3-2 17:25:56 INFO - jsonschema == 2.5.1 17:25:56 INFO - manifestparser == 1.1 17:25:56 INFO - mozInstall == 1.12 17:25:56 INFO - mozcrash == 1.0 17:25:56 INFO - mozdebug == 0.1 17:25:56 INFO - mozdevice == 0.49 17:25:56 INFO - mozfile == 1.2 17:25:56 INFO - mozhttpd == 0.7 17:25:56 INFO - mozinfo == 0.9 17:25:56 INFO - mozleak == 0.1 17:25:56 INFO - mozlog == 3.4 17:25:56 INFO - moznetwork == 0.27 17:25:56 INFO - mozprocess == 0.24 17:25:56 INFO - mozprofile == 0.28 17:25:56 INFO - mozrunner == 6.13 17:25:56 INFO - mozscreenshot == 0.1 17:25:56 INFO - mozsystemmonitor == 0.3 17:25:56 INFO - moztest == 0.8 17:25:56 INFO - mozversion == 1.4 17:25:56 INFO - psutil == 3.1.1 17:25:56 INFO - requests == 1.2.3 17:25:56 INFO - wsgiref == 0.1.2 17:25:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:56 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 0x15331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a5980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a2d00>, '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 0x18a3a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a3eb0>, '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': '6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637', '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 17:25:56 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 17:25:56 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 17:25:56 INFO - Using env: {'DISPLAY': ':0', 17:25:56 INFO - 'HOME': '/home/cltbld', 17:25:56 INFO - 'LANG': 'en_US.UTF-8', 17:25:56 INFO - 'LANGUAGE': 'en_US:en', 17:25:56 INFO - 'LOGNAME': 'cltbld', 17:25:56 INFO - 'MAIL': '/var/mail/cltbld', 17:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:56 INFO - 'MOZ_NO_REMOTE': '1', 17:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:56 INFO - 'NO_EM_RESTART': '1', 17:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:56 INFO - 'PWD': '/builds/slave/test', 17:25:56 INFO - 'SHELL': '/bin/bash', 17:25:56 INFO - 'SHLVL': '1', 17:25:56 INFO - 'TERM': 'linux', 17:25:56 INFO - 'TMOUT': '86400', 17:25:56 INFO - 'USER': 'cltbld', 17:25:56 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637', 17:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:56 INFO - '_': '/tools/buildbot/bin/python'} 17:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:56 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)) 17:25:56 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)) 17:25:56 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)) 17:25:56 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)) 17:25:56 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)) 17:25:56 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)) 17:25:56 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)) 17:25:56 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)) 17:25:56 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)) 17:25:56 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)) 17:25:56 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)) 17:25:56 INFO - Cleaning up... 17:25:56 INFO - Return code: 0 17:25:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x15331f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1700a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18a5980>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18a2d00>, '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 0x18a3a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a3eb0>, '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': '6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637', '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 17:25:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:25:56 INFO - Using env: {'DISPLAY': ':0', 17:25:56 INFO - 'HOME': '/home/cltbld', 17:25:56 INFO - 'LANG': 'en_US.UTF-8', 17:25:56 INFO - 'LANGUAGE': 'en_US:en', 17:25:56 INFO - 'LOGNAME': 'cltbld', 17:25:56 INFO - 'MAIL': '/var/mail/cltbld', 17:25:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:56 INFO - 'MOZ_NO_REMOTE': '1', 17:25:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:56 INFO - 'NO_EM_RESTART': '1', 17:25:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:56 INFO - 'PWD': '/builds/slave/test', 17:25:56 INFO - 'SHELL': '/bin/bash', 17:25:56 INFO - 'SHLVL': '1', 17:25:56 INFO - 'TERM': 'linux', 17:25:56 INFO - 'TMOUT': '86400', 17:25:56 INFO - 'USER': 'cltbld', 17:25:56 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637', 17:25:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:56 INFO - '_': '/tools/buildbot/bin/python'} 17:25:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:25:56 INFO - Cleaning up... 17:25:56 INFO - Return code: 0 17:25:56 INFO - Running post-action listener: _resource_record_post_action 17:25:56 INFO - Running post-action listener: _start_resource_monitoring 17:25:56 INFO - Starting resource monitoring. 17:25:56 INFO - [mozharness: 2017-02-10 01:25:56.556662Z] Finished create-virtualenv step (success) 17:25:56 INFO - [mozharness: 2017-02-10 01:25:56.557144Z] Running install step. 17:25:56 INFO - Running pre-action listener: _resource_record_pre_action 17:25:56 INFO - Running main action method: install 17:25:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:25:56 INFO - Reading from file tmpfile_stdout 17:25:56 INFO - Detecting whether we're running mozinstall >=1.0... 17:25:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:25:56 INFO - Reading from file tmpfile_stdout 17:25:56 INFO - Output received: 17:25:56 INFO - Usage: mozinstall [options] installer 17:25:56 INFO - Options: 17:25:56 INFO - -h, --help show this help message and exit 17:25:56 INFO - -d DEST, --destination=DEST 17:25:56 INFO - Directory to install application into. [default: 17:25:56 INFO - "/builds/slave/test"] 17:25:56 INFO - --app=APP Application being installed. [default: firefox] 17:25:56 INFO - mkdir: /builds/slave/test/build/application 17:25:56 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'] 17:25:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 17:26:13 INFO - Reading from file tmpfile_stdout 17:26:13 INFO - Output received: 17:26:13 INFO - /builds/slave/test/build/application/firefox/firefox 17:26:13 INFO - Running post-action listener: _resource_record_post_action 17:26:13 INFO - [mozharness: 2017-02-10 01:26:13.283472Z] Finished install step (success) 17:26:13 INFO - [mozharness: 2017-02-10 01:26:13.283804Z] Running run-tests step. 17:26:13 INFO - Running pre-action listener: _resource_record_pre_action 17:26:13 INFO - Running main action method: run_tests 17:26:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:26:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:26:13 INFO - Python 2.7.3 17:26:13 INFO - Return code: 0 17:26:13 INFO - grabbing minidump binary from tooltool 17:26:13 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')]} 17:26:13 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 0x18a2d00>, '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 0x18a3a00>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x18a3eb0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:26:13 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 17:26:13 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 17:26:13 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 17:26:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:26:13 INFO - Return code: 0 17:26:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:26:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:26:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:26:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:26:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:26:13 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/Tn4IGwBxS7669Hnno10MvQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 17:26:13 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/Tn4IGwBxS7669Hnno10MvQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-050 --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 17:26:13 INFO - Using env: {'DISPLAY': ':0', 17:26:13 INFO - 'HOME': '/home/cltbld', 17:26:13 INFO - 'LANG': 'en_US.UTF-8', 17:26:13 INFO - 'LANGUAGE': 'en_US:en', 17:26:13 INFO - 'LOGNAME': 'cltbld', 17:26:13 INFO - 'MAIL': '/var/mail/cltbld', 17:26:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:26:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:26:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:13 INFO - 'MOZ_NO_REMOTE': '1', 17:26:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:26:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:13 INFO - 'NO_EM_RESTART': '1', 17:26:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:13 INFO - 'PWD': '/builds/slave/test', 17:26:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:26:13 INFO - 'SHELL': '/bin/bash', 17:26:13 INFO - 'SHLVL': '1', 17:26:13 INFO - 'TERM': 'linux', 17:26:13 INFO - 'TMOUT': '86400', 17:26:13 INFO - 'USER': 'cltbld', 17:26:13 INFO - 'XDG_SESSION_COOKIE': '6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637', 17:26:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:13 INFO - '_': '/tools/buildbot/bin/python'} 17:26:13 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/Tn4IGwBxS7669Hnno10MvQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-050', '--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 17:26:13 INFO - mozversion application_buildid: 20170210002235 17:26:13 INFO - mozversion application_changeset: 63752d3df9fa09ecd3283eaccb950cc5607fbab1 17:26:13 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:26:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:26:13 INFO - mozversion application_name: Firefox 17:26:13 INFO - mozversion application_remotingname: firefox-dev 17:26:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:26:13 INFO - mozversion application_vendor: Mozilla 17:26:13 INFO - mozversion application_version: 53.0a2 17:26:13 INFO - mozversion platform_buildid: 20170210002235 17:26:13 INFO - mozversion platform_changeset: 63752d3df9fa09ecd3283eaccb950cc5607fbab1 17:26:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:26:13 INFO - mozversion platform_version: 53.0a2 17:26:13 INFO - using testdate: 1486689973 17:26:13 INFO - actual date: 1486689973 17:26:13 INFO - starting webserver on 'localhost:52207' 17:26:13 INFO - SUITE-START | Running 2 tests 17:26:13 INFO - TEST-START | dromaeo_css 17:26:13 INFO - operating with platform_type : linux_ 17:26:13 INFO - Initialising browser for dromaeo_css test... 17:26:13 INFO - TEST-INFO | started process 9015 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp88sH4D/profile http://localhost:52207/getInfo.html) 17:26:17 INFO - PROCESS | 9015 | __metrics Screen width/height:1600/1200 17:26:17 INFO - PROCESS | 9015 | colorDepth:24 17:26:17 INFO - PROCESS | 9015 | Browser inner width/height: 1024/697 17:26:17 INFO - PROCESS | 9015 | __metrics 17:26:18 INFO - PROCESS | 9015 | 1486689978493 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/tmp88sH4D/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmp88sH4D/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmp88sH4D/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmp88sH4D/profile/extensions/talos-powers@TalosPowersService.js:55:9 17:26:18 ERROR - PROCESS | 9015 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 17:26:19 INFO - TEST-INFO | 9015: exit 0 17:26:19 INFO - Browser initialized. 17:26:19 INFO - Running cycle 1/1 for dromaeo_css test... 17:26:19 INFO - TEST-INFO | started process 9141 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp88sH4D/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:26:31 INFO - PROCESS | 9141 | RSS: Main: 144494592 17:26:31 INFO - PROCESS | 9141 | 17:29:30 INFO - PROCESS | 9141 | Cycle 1(1): loaded http://localhost:52207/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52207/tests/dromaeo/cssquery-ext.html) 17:29:32 INFO - PROCESS | 9141 | RSS: Main: 153010176 17:29:32 INFO - PROCESS | 9141 | 17:31:19 INFO - PROCESS | 9141 | ************************* 17:31:19 INFO - PROCESS | 9141 | A coding exception was thrown and uncaught in a Task. 17:31:19 INFO - PROCESS | 9141 | 17:31:19 ERROR - PROCESS | 9141 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:31:19 INFO - PROCESS | 9141 | Full stack: 17:31:19 INFO - PROCESS | 9141 | ************************* 17:32:34 INFO - PROCESS | 9141 | Cycle 1(1): loaded http://localhost:52207/tests/dromaeo/cssquery-ext.html (next: http://localhost:52207/tests/dromaeo/cssquery-jquery.html) 17:32:34 INFO - PROCESS | 9141 | RSS: Main: 151797760 17:32:34 INFO - PROCESS | 9141 | 17:35:36 INFO - PROCESS | 9141 | Cycle 1(1): loaded http://localhost:52207/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52207/tests/dromaeo/cssquery-mootools.html) 17:35:37 INFO - PROCESS | 9141 | RSS: Main: 153169920 17:35:37 INFO - PROCESS | 9141 | 17:38:38 INFO - PROCESS | 9141 | Cycle 1(1): loaded http://localhost:52207/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52207/tests/dromaeo/cssquery-prototype.html) 17:38:39 INFO - PROCESS | 9141 | RSS: Main: 149594112 17:38:39 INFO - PROCESS | 9141 | 17:41:42 INFO - PROCESS | 9141 | Cycle 1(1): loaded http://localhost:52207/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52207/tests/dromaeo/cssquery-yui.html) 17:41:42 INFO - PROCESS | 9141 | RSS: Main: 153866240 17:41:42 INFO - PROCESS | 9141 | 17:44:45 INFO - PROCESS | 9141 | Cycle 1(1): loaded http://localhost:52207/tests/dromaeo/cssquery-yui.html (next: http://localhost:52207/tests/dromaeo/cssquery-dojo.html) 17:44:45 INFO - PROCESS | 9141 | RSS: Main: 154157056 17:44:45 INFO - PROCESS | 9141 | 17:44:45 INFO - PROCESS | 9141 | __start_tp_report 17:44:45 INFO - PROCESS | 9141 | _x_x_mozilla_page_load 17:44:45 INFO - PROCESS | 9141 | _x_x_mozilla_page_load_details 17:44:45 INFO - PROCESS | 9141 | |i|pagename|runs| 17:44:45 INFO - PROCESS | 9141 | |0;dojo.html;3245.448273793455;3369.7135743461813;3383.4079036168664;3390.2033022239752;3394.2532642818587;5610.467005634463;5661;5661.915071273929;5676.091825307952;5681.886362272752;5625.353084395296;5672.347680016799;5688.459596338352;5695.886082278352;5728.656280623155;5174.197999310103;5174.353205849269;5205.661631993928;5221.39953905302;5273.182656688219;5249.1338929076655;5249.370075590915;5259.421463638997;5275.446078161795;5278.947210527903;5096.464871188509;5098.490150984909;5235.869103272411;5237.79048838046;5286.841394758163;5112.10538155825;5149.021685879671;5184.818531351385;5188.662736922107;5218.2172674099;5057.49425057495;5189.325387699612;5190.4031036430915;5214.165733482625;5246.973765131188;5640.492355687967;5682.40334764852;5694.572907031989;5696.829095127111;5704.344000439961;5884.705764711747;5891.440313170242;5933.703314834284;5953.970230148865;6058.545609079292;5998.700064996733;6022.457978781887;6035.185249991283;6048.123022161806;6066.696665166724;5609.214709940612;5616.550675945915;5621.7751289948355;5622.803201887955;5643.887122257573;5890.204822348928;6011.068284415923;6085.421884920926;6097.878042439126;6110.663913484712;5915.911261331084;5951.851203719942;5974.133750606138;6006.639601623917;6017.819465416044;6051.969740151271;6056.121862329937;6073.605215660968;6082.878342433215;6086.147939288503;5828.300603927556;5836.970815145982;6040.033594624839;6063;6063.029915213545;5935.6735379553675;5936.990711579042;5964.224650795369;5990.5507086968655;6044.758209671564;4621.168189725814;4625.121226966933;4661.510541393172;4662.277347011219;4685.929711054337;4095.610916962884;4147.315692910636;4163.208990291835;4169.207850508394;4183.247015537172;5765.4811067004175;5786.450287222707;5789.739461724233;5820.505257053113;5846.1523079153285;6017.428344307284;6033.456988870935;6045.425684559959;6064;6071;5615.0940399191695;5678.119891416754;5805.477507024304;5806.506446951972;5843.503302219274;5136.1525348317855;5151.7166555839785;5175.792968281302;5183.97408012965;5221.947780522222;6290.591111577733;6305.558610897193;6332.271788744261;6340.8414789629705;6355.428011478989;5896.882062358814;6149.600275982047;6159.384061593805;6161.199044124414;6162.691865406622;6135.355787642412;6189.721462534287;6199.814005579839;6212.658303793335;6262.34245404226;5997.513056453618;6024.487918526799;6033.3061697905305;6045.6070355426755;6072.240969878765;6049.485793707584;6101.084837274267;6101.816945491642;6101.84745381369;6117.571769976237;5811.302643682785;5853.180554722428;5877.823665289877;5903.734331954986;5927.229460170322;5940.346561878277;5941.346451890375;5948.821535353946;5949.762009519571;5951.494122999594;5904.291485021825;5927.347991720993;5949.732262048305;5955.76176952917;5964.224650795369;5770.192173095686;5884.58807883444;5898.94101058984;5903.26209223847;5940.108983652487;5826.592138550261;5835.620684655484;5846.649201047951;5871.412858714094;5889.440503152194 17:44:45 INFO - PROCESS | 9141 | |1;ext.html;526.0218695393704;581.5260562641447;599.2479438304928;615.1818081951005;630.2940706408823;45743;47736.76131619346;48140;53313.466865331335;53497;50044.749776251156;51348.716282092966;51401.485985140134;51442.228366574534;51573;9298.256139508856;9586;9606.183474404685;10469.947650261738;10855.24013319068;10883.18376121794;10915.890841091606;10995.560177592886;11016;11028.724281892937;11058.502367393447;11091.168162387854;11092.057175140082;11102.55589776408;11173.050290725298;10895.073918716918;10972.670819875417;11020.283681560713;11071.114310855111;11075.446227688624;10359.63741269052;10552.47237638115;10597;10602.363858168457;10607.310524815863;43413.34879976803;43664.3450348245;43738.78130609358;43820.3426948596;43842;4253.064325848309;4310.978445107754;4342.564672274259;4382.07976324969;4387.122575484916;32261.677383226102;32673.183170420692;32823.17942051444;33002;33037.66962330394;4616.399868017136;4721.032188401369;4754.904901901978;4766.594839438651;4787.066522028206;365489;366788;369502;369537;369610;62673;62687;62845;62895;63246.68376658087;64930.675346622964;65331.346686532524;65665;65798.67100664465;65808;19054.14256358467;19113.61772764537;19276.32532861343;19306.8069319305;19318.806811931983;13286.933565332305;13789.793153102712;14507.782383264259;14757.631059223391;14801.333939972727;19472.844482660996;19754.11106500211;19862.801371986385;19890.90054549718;19934;6951.93048069523;7155.606441645656;7174.457491639323;7203.423726101899;7276.599787011659;960.5485421851719;972.5866506734609;974.28390133252;979.7893452907659;984.5618699678574;33479.497807532905;34084.1478963023;34084.14789630279;34085;34246;1175.7707247086908;1187.329159025148;1199.1545960098285;1227.5826219085554;1300.0379719008056;17791.19939602721;17840.19719112643;17968.91015544914;17997.37009204698;18112.728309075374;502852;507098;511039;513065;515253;70067.64966175136;70867.64566177136;70997;71105.28894711091;71257;1450.361840790049;1481.9110853348618;1496.7979322791284;1508.4720347878374;1519.01264178285;32502.512462313556;32826;33363.999080027636;33575.664243357256;33635.831820840736;58185.418145818;59759.40240597539;59815.40184598098;59831.401685982586;59924.700376497836;371049;372214;372509;372986;374393;30793.538096928114;31658.683413165574;31741.68258317387;31796.68203317937;31830;47038.29442558296;47301;47517.28724069211;48058.27912581384;48621.756891215315;39805;40086.79956600198;40851.18297633971;40866.38700419437;41926.79036604797;39166.80416597899;39509.2098158041;39858.60141398549;39896;40437.39343909785;40576;40735;40763.38854917238;43964.78017609892;45066.549334506235;32464.675353246166;34561.82719086489;34803.65196348004;34808.47787283243;34906.825465872505;27393.452130957667;28099.57850632283;28346.71653283441;28366.29084272827;28392.29019274452 17:44:45 INFO - PROCESS | 9141 | |2;jquery.html;429.5339556581109;432.0710472484159;437.9408779814726;442.1554830274176;449.6590333819718;20313.289034883765;20558.48603784904;21799.891000545016;21830.23594174204;22016.229431969885;20719.792802071974;22444.214452494165;22980.77019229807;23049.078036878505;23342.183023594178;5992.37080106588;6132.141500189977;6152.200213972177;6153;6179.196704428418;5941.138534912435;6204.78283260086;6254.562180647356;6351.079093531435;6362.077498762676;5953.43442372976;6058.969705151468;6301.054841773725;6315.98944168933;6326.019466982625;5982.820515384546;6359.904601430982;6379.744810207586;6384.968075159641;6393.264774550939;5993.850153746148;6064.484518815906;6221.906671399933;6234.438900498932;6238.875222495525;24261.393465163514;24461.38846528833;25097.874510627513;25232.243032709048;25280.620790688154;2807.410443806803;2922.722341377566;2928.6485621725315;2935.1781501179703;2944.05790147153;10997.010269075821;11454;11614.825777613343;11965.820512692317;16591.751123733153;2003.7996200379991;2039.367795983235;2066.2045112631595;2067.9379618611465;2088.9164433422643;93262;93403.53298233465;93503;95394.0460595399;96568.51715741376;10513;10830.133589312836;11058.778824423627;12045;12678.366081695878;14963.476278330207;14983.925080374747;15078.095314281178;15100.471483498024;15177.468788592567;8765.649374025095;8973.775655608531;8982.640694372283;9013.63945442175;9049.185573298435;9039.68361107358;9061.13919177677;9071;9253.583588738524;9326.160645541799;4584.908301834012;4596.172688916027;4639.536046395334;4657.883552911204;4748.335233067304;2059.124871929424;2136.626090434168;2144.721186245778;2154.666026765854;2165.8700477971374;996.3673067602125;998.1266391907081;1001.439194051319;1013.2552573858209;1015.9593616255415;20557.486062848548;20740.377788666363;20816.167353305696;20908.30509990153;20925.58148837045;998.4109375468508;1014.60937539048;1022.2077889635443;1031.376017509411;1037.7872536130076;11104.611338603272;11416.714582135513;11418.143639227092;11496.597619083292;11540.307581545134;670282;676821.2119092168;689029;694826;728651;85869;86385;110388.4480577608;111644.44177779059;111955;1115.4478533126155;1150.5742875136086;1175.4416652090188;1184.9703757405962;1187.5724739093919;19213.711794322815;19332.710009350154;19609;19609.607807844048;19696.507587310432;46441.767791160826;46866.76566617282;47090.52909470862;47156;48342.27486587774;64405.67797160984;67009;68543;69543.30456695368;69612.65193673999;9152.22206112488;9247.0752924707;9297;9399.389039712396;9402.670906518239;10173.694789156338;12758.68103297425;13163.012774041794;13222.867771322164;13308.068435209443;10825.242233043611;10989.835152472879;11032.944835275772;11122.388268644978;11438.428078596204;9792.559334830092;10873.238873278795;11007.284526505751;11572.537098515964;11642.068634509389;11417.885821141683;11501.597444089417;11590.246633968765;11604.535818567163;11959.461824217757;8807.559622019002;8890.377673562789;8930.598123084606;9089.227415669478;9111.498867562348;10002.499875006366;10600.681979540317;11303.717407064889;11531.481083351437;11589.536418543164 17:44:45 INFO - PROCESS | 9141 | |3;mootools.html;1457.7813328000805;1483.2583708145928;1492.67907399909;1501.9098854068754;1520.2398800599701;8634.309255259579;8781.692640757576;9148.954255228715;9172.633094676214;9228.077192280769;9078.682246121387;9144.268458523318;9192.98877123516;9235.492047937361;9326.347155699104;2367.573836709392;2407.3861165402886;2408.915687950922;2410.4937963027696;2422.358075110097;2412.517496500698;2430.1251549442186;2431.8297719159664;2451.264620613809;2457.6436416719566;2347.9882600586975;2367.029517897662;2367.230650038736;2374.252110585169;2397.7602239776056;2330.0912644068826;2332.102140675835;2344.7069116360453;2356.1400088967575;2361.2562042956415;2312.167619656922;2314.2478694424212;2375.1924345722364;2375.4417711837705;2381.749916258785;9095.863562046574;9221.031791661846;9236.353455258135;9250.90749092514;9271.490068046254;5441.319835020622;5503.807366742185;5566.526845218162;5568.9443105569235;5582.190582365534;3430.4168291390524;3455.4125798614295;3538.7345949053924;3611.783293002402;3686.9262614747554;1462.2104063805532;1472.646564824445;1481.4148411377553;1494.0736743219275;1522.216058729755;12362.75274494505;12476.937615311865;12547.498100075985;12588.937055314756;12655;4498.617617502484;4599.816007359668;4714.104320179155;4720.834770783006;4726.125666751662;10104.949475252724;10156.746081348025;10163.390196588229;10179;10190.694279171637;5553.361363443175;5557.083081291623;5561.916571251434;5562.9443705563235;5571;4539.72761634303;4678.1813182692895;4998.650094493423;5021.447640759514;5047.848564543069;3977.1846771411792;4054.5134583850127;4100.261952848516;4155;4178.7283826551175;1138.8007098757685;1140.9030232430337;1154.261272785418;1157.8784227656142;1162.023899924051;878.5255961780695;883.5273128876021;886.3972498700816;903.8734577159072;911.9772005699778;5888.205092312569;5959;5985.760569577168;6073.878522429527;6109.14471973924;636.6593872278308;651.5732195412013;654.5287393076977;655.9016147577902;665.6006396162264;3851.8651847185215;3862.5558060822805;3878.728489005799;3884.3784994401326;3900.0054985978395;10644.414557199274;10969.945150274198;10985.39580323074;11010.50452729629;11018.283811552223;10576.471176441148;10804.945975270231;10927.890721092846;10931.945340273247;10999.34003959765;8236.83526329482;8311.750647480585;8361.163883611713;8396.992360916607;8466.111058338909;5861.443162899518;5911.556633252438;5938.287405511366;6043.486303664238;6063.605865618721;9775.266854986046;9914.859791123825;10058.647947321808;10155.492225388849;10253.33353332031;9688.370255933341;10076.949615251877;10102.494875256061;10106.090451859369;10567.365958042543;7681.270279323456;7963.323117534843;8080.070791858776;8161.877571836546;8315.916840831756;8858.867116993379;8904.376693631642;8935.28517718568;8952;8966.910330896608;7623.733169339046;7751.612419379121;7885.053793544811;7935.920640793518;7954.5624990626075;7325.706971721072;7361.963190184015;7369.484136110421;7460.738874139379;7587.962060189664;6497.480201583957;6731.461483081243;6770.729170833111;6795.218549866829;6841.042254084532;5343.011542864582;5354.866128346823;5400.081986062457;5412.729363531729;5457.20870473787;5266.368035835724;5347.224652425299;5367.731613419392;5373.650712703662;5377.112776391851 17:44:45 INFO - PROCESS | 9141 | |4;prototype.html;373.65436970802;395.1188848867028;397.6957627415028;397.87069202509184;405.1512082187816;5363.383210930744;5454.781808727646;5501.174823776436;5676.489115979561;5695.288088988877;5396.136618141099;5519.896020795847;5535.675016493073;5537;5542.362628297747;4414.381986521889;4444.97765513932;4448.132614140244;4453.28747400416;4486.327050942368;4365.257906155945;4398.560143985608;4420.734755914639;4462.174497717932;4478.395416618763;4334;4349.369341445488;4361.716488428242;4367.585079417466;4391.429114215148;4362.541933097027;4373.431453910987;4379.8467053653285;4387.319965405367;4412.249587850333;3603.3333833240936;3925.3523168677134;3926.959355770723;3934.6852251819787;3953.327934251184;5313.893722125575;5348.705821179834;5381.704006279653;5382.6770393776105;5389.461053894618;4929.408470983469;4943.6539442239055;4957.5786058185095;4961.330220420269;4961.824432363291;5546.805861794858;5740.741666625012;5753.597248192586;5778.3354914184565;5780.265920223958;4156.334986402191;4170;4175.498940127174;4181.811818468176;4181.958180418187;5999.250093738283;6009.819705408845;6010.519158467312;6010.609310394811;6027.819165425044;4216.262154123077;4271.914561708749;4288.099499105223;4289.6139347458875;4331.960329520955;4327.870163895088;4368.170047690928;4370.847020354272;4379.3649920761945;4399.5160532341415;4976.925346119811;4982.434046466073;4990.351254336913;4995.9508503214;5012.1980483122525;5652.91915905824;5694.857628559319;5719.799807006818;5752.511036561939;5812.9536683396545;1417.8015077889104;1453;1453.0700351774872;1458.4457905995653;1460.8831293496494;984.5963155106515;984.7193549838405;1011.868457100587;1018.1701912940929;1022.9693109206736;5468.48049435311;5478.808241711601;5490.615656903979;5498.45015498455;5501.614886957875;5750.9360768258;5782.190493330937;5802.21670074543;5814.331351894586;5833.591648584558;5549.694766787866;5588.552915766729;5630.690312032795;5655.236543066716;5726.770929162787;3038.0252835656556;3058.357744873557;3065.6167979002626;3071.800332978349;3078.5074388097796;5939.524838012949;6003.309619393738;6012.699365031731;6033.7586496540525;6059.484943779828;6101.145839582462;6132.5707200495535;6138.324784273726;6143.96928015366;6172.475339596184;6225.750969961241;6309.936900631027;6309.936900631027;6321.399467050623;6324.810255692337;5898.292204935436;5965;6002.369751176238;6016.909746353896;6024.728887199999;5906.822795316148;5940.316863560746;5967.836271926933;5976.372480889618;5983.277608687949;6128.693565321627;6160.507159427325;6182.165407669907;6201.131841542097;6267.717952692049;4229.598188172119;4269.996550810619;4282.850100246476;4294.656427485731;4300.967767735783;5784;5890.676012819336;5932.79235226765;5971.970140149271;5995.850103747442;5748.827535173951;5784.652920824764;5786.681732504752;5798.578838485314;5800.8259752207505;5792.160136780059;5816.782832446443;5846.5615078870105;5847.590668653153;5874.794382196603;5636.960684133824;5787.94212057874;5830.766769329349;5841.240638716939;5844.444777746107;5778.16216648592;5833.562482813891;5850.736716847667;5856.443637854397;5875.471207591338;5473.343198816167;5678.77284908599;5706.457886500776;5734.684592347461;5744.770209191753 17:44:45 INFO - PROCESS | 9141 | |5;yui.html;826.7519744076775;834.3450391442718;840.4915026409022;908.1191244492842;945.498885590637;15557.766633500492;15774;15936.760948585752;15970.68058638828;16356.345746170155;16055;16059.598510037255;16288.674226515463;16308.184590770474;16381;840.4621042532784;852.5566705313233;854.8033952191;855.3713020929612;856.4604299291469;799.7440818937943;845.2941793602319;845.9703910363138;852.3394369363762;853.6841368693592;874.021096372061;878.0341624213378;879.4503435352905;884.2174675412274;884.5798245833242;882.095851751953;882.4925667741043;883.1609970528024;884.4472204871987;885.4642941020654;643.5237923936301;647.841278886671;648.3095503289029;649.3052433895733;650.0314531348257;16046.919765401215;16147.273372698257;17058.573535661584;17772.733408998876;17815.910920445316;14216.289185540682;14542;14556.272186390637;14738;14978.62553436162;13149.342532873414;13285.667858303523;13290.26903520306;13348.2658453785;13411.664708382272;3964.5638979712207;3986.123052928351;3988.68090552758;4028.617281358266;4056.4320995060716;80455.19544804536;81216.18783812145;82027;82095;82912;11925.821112683318;12055.939720301518;12090.637280881587;12120.81818772719;12170.269783812999;23838.761612383652;23897.641535376635;24225.15211967608;24570.262892113264;24776.132835351036;8554.957225213959;8636.827263454821;8737.21365077146;8739.038705742363;8806.20744133031;4737.526247375304;4835.588974937099;4879.804807807648;4887.877803054952;4896.804127834918;3990.4812374391145;4004.6796256299426;4034.35450327952;4075.2257071156387;4094.0379010932406;659.3571268013649;665.6505334699225;669.397542212013;669.7120238297579;670.4234358451728;656.7241758461457;661.6526323680107;671.4930227678071;673.1719984419192;679.3546131175403;10140.543675534618;10892.727681808019;11234.550617975354;11346.48940797666;11377.431128443544;695.2005194026808;700.4851434195862;702.1293595941098;702.2100137345486;887.2946007923587;5271.42014378418;5547.306586676666;5586.832395028156;5592.133219351007;5706.115552089433;67748.6612566934;68103;69632;71851.28148718446;79414;59749;69152.3084769146;69584.3041569588;70139;70216.297837022;56960.43039569634;62253.905293815296;62845.68577157085;64166.6791666048;64647.35352646413;11421;11516.424178791194;11658;11919.225250358699;12085.39573021363;36998;43123.353149703406;43607.78196108999;43608.34587481254;44671;52495.47504525058;54596.18105728338;54849.177262341895;55078.72460637671;56497.43502565086;13284.136531125447;13525.932370338085;13541.729165416833;13595.796063058864;13633.727325453634;15324.540263792103;15466.690666186838;15560.492869888405;15641.608959776097;15740.60648483797;14012.509562165274;14179.503717369842;14279;14279.143251404948;14506.274686265433;14992.925035374754;15243.771343429635;15252;15670.921645392156;15910.12494312824;14533.636659083608;14630.304711336377;14732.263386830402;14984.775228371365;15090.094594324375;11791.646250612152;11874.52501899949;11877.168598198043;11933.82099268529;12274.570390036663;12014.381304304545;12386.132970691964;12404.875951240372;12411.751764964469;12464.127511074137 17:44:45 INFO - PROCESS | 9141 | __end_tp_report 17:44:45 INFO - PROCESS | 9141 | __start_cc_report 17:44:45 INFO - PROCESS | 9141 | _x_x_mozilla_cycle_collect,311 17:44:45 INFO - PROCESS | 9141 | __end_cc_report 17:44:45 INFO - PROCESS | 9141 | __startTimestamp1486691085317__endTimestamp 17:44:45 INFO - PROCESS | 9141 | 17:44:45 INFO - PROCESS | 9141 | ------- Summary: start ------- 17:44:45 INFO - PROCESS | 9141 | Number of tests: 6 17:44:45 INFO - PROCESS | 9141 | 17:44:45 INFO - PROCESS | 9141 | [#0] dojo.html Cycles:165 Average:5631.76 Median:5853.18 stddev:617.16 (10.5%) stddev-sans-first:589.98 17:44:45 INFO - PROCESS | 9141 | Values: 3245.4 3369.7 3383.4 3390.2 3394.3 5610.5 5661.0 5661.9 5676.1 5681.9 5625.4 5672.3 5688.5 5695.9 5728.7 5174.2 5174.4 5205.7 5221.4 5273.2 5249.1 5249.4 5259.4 5275.4 5278.9 5096.5 5098.5 5235.9 5237.8 5286.8 5112.1 5149.0 5184.8 5188.7 5218.2 5057.5 5189.3 5190.4 5214.2 5247.0 5640.5 5682.4 5694.6 5696.8 5704.3 5884.7 5891.4 5933.7 5954.0 6058.5 5998.7 6022.5 6035.2 6048.1 6066.7 5609.2 5616.6 5621.8 5622.8 5643.9 5890.2 6011.1 6085.4 6097.9 6110.7 5915.9 5951.9 5974.1 6006.6 6017.8 6052.0 6056.1 6073.6 6082.9 6086.1 5828.3 5837.0 6040.0 6063.0 6063.0 5935.7 5937.0 5964.2 5990.6 6044.8 4621.2 4625.1 4661.5 4662.3 4685.9 4095.6 4147.3 4163.2 4169.2 4183.2 5765.5 5786.5 5789.7 5820.5 5846.2 6017.4 6033.5 6045.4 6064.0 6071.0 5615.1 5678.1 5805.5 5806.5 5843.5 5136.2 5151.7 5175.8 5184.0 5221.9 6290.6 6305.6 6332.3 6340.8 6355.4 5896.9 6149.6 6159.4 6161.2 6162.7 6135.4 6189.7 6199.8 6212.7 6262.3 5997.5 6024.5 6033.3 6045.6 6072.2 6049.5 6101.1 6101.8 6101.8 6117.6 5811.3 5853.2 5877.8 5903.7 5927.2 5940.3 5941.3 5948.8 5949.8 5951.5 5904.3 5927.3 5949.7 5955.8 5964.2 5770.2 5884.6 5898.9 5903.3 5940.1 5826.6 5835.6 5846.6 5871.4 5889.4 17:44:45 INFO - PROCESS | 9141 | 17:44:45 INFO - PROCESS | 9141 | [#1] ext.html Cycles:180 Average:60098.36 Median:373689.50 stddev:111332.53 (29.8%) stddev-sans-first:111554.99 17:44:45 INFO - PROCESS | 9141 | Values: 526.0 581.5 599.2 615.2 630.3 45743.0 47736.8 48140.0 53313.5 53497.0 50044.7 51348.7 51401.5 51442.2 51573.0 9298.3 9586.0 9606.2 10469.9 10855.2 10883.2 10915.9 10995.6 11016.0 11028.7 11058.5 11091.2 11092.1 11102.6 11173.1 10895.1 10972.7 11020.3 11071.1 11075.4 10359.6 10552.5 10597.0 10602.4 10607.3 43413.3 43664.3 43738.8 43820.3 43842.0 4253.1 4311.0 4342.6 4382.1 4387.1 32261.7 32673.2 32823.2 33002.0 33037.7 4616.4 4721.0 4754.9 4766.6 4787.1 365489.0 366788.0 369502.0 369537.0 369610.0 62673.0 62687.0 62845.0 62895.0 63246.7 64930.7 65331.3 65665.0 65798.7 65808.0 19054.1 19113.6 19276.3 19306.8 19318.8 13286.9 13789.8 14507.8 14757.6 14801.3 19472.8 19754.1 19862.8 19890.9 19934.0 6951.9 7155.6 7174.5 7203.4 7276.6 960.5 972.6 974.3 979.8 984.6 33479.5 34084.1 34084.1 34085.0 34246.0 1175.8 1187.3 1199.2 1227.6 1300.0 17791.2 17840.2 17968.9 17997.4 18112.7 502852.0 507098.0 511039.0 513065.0 515253.0 70067.6 70867.6 70997.0 71105.3 71257.0 1450.4 1481.9 1496.8 1508.5 1519.0 32502.5 32826.0 33364.0 33575.7 33635.8 58185.4 59759.4 59815.4 59831.4 59924.7 371049.0 372214.0 372509.0 372986.0 374393.0 30793.5 31658.7 31741.7 31796.7 31830.0 47038.3 47301.0 47517.3 48058.3 48621.8 39805.0 40086.8 40851.2 40866.4 41926.8 39166.8 39509.2 39858.6 39896.0 40437.4 40576.0 40735.0 40763.4 43964.8 45066.5 32464.7 34561.8 34803.7 34808.5 34906.8 27393.5 28099.6 28346.7 28366.3 28392.3 17:44:45 INFO - PROCESS | 9141 | 17:44:45 INFO - PROCESS | 9141 | [#2] jquery.html Cycles:180 Average:36163.70 Median:24779.63 stddev:113662.31 (458.7%) stddev-sans-first:113949.49 17:44:45 INFO - PROCESS | 9141 | Values: 429.5 432.1 437.9 442.2 449.7 20313.3 20558.5 21799.9 21830.2 22016.2 20719.8 22444.2 22980.8 23049.1 23342.2 5992.4 6132.1 6152.2 6153.0 6179.2 5941.1 6204.8 6254.6 6351.1 6362.1 5953.4 6059.0 6301.1 6316.0 6326.0 5982.8 6359.9 6379.7 6385.0 6393.3 5993.9 6064.5 6221.9 6234.4 6238.9 24261.4 24461.4 25097.9 25232.2 25280.6 2807.4 2922.7 2928.6 2935.2 2944.1 10997.0 11454.0 11614.8 11965.8 16591.8 2003.8 2039.4 2066.2 2067.9 2088.9 93262.0 93403.5 93503.0 95394.0 96568.5 10513.0 10830.1 11058.8 12045.0 12678.4 14963.5 14983.9 15078.1 15100.5 15177.5 8765.6 8973.8 8982.6 9013.6 9049.2 9039.7 9061.1 9071.0 9253.6 9326.2 4584.9 4596.2 4639.5 4657.9 4748.3 2059.1 2136.6 2144.7 2154.7 2165.9 996.4 998.1 1001.4 1013.3 1016.0 20557.5 20740.4 20816.2 20908.3 20925.6 998.4 1014.6 1022.2 1031.4 1037.8 11104.6 11416.7 11418.1 11496.6 11540.3 670282.0 676821.2 689029.0 694826.0 728651.0 85869.0 86385.0 110388.4 111644.4 111955.0 1115.4 1150.6 1175.4 1185.0 1187.6 19213.7 19332.7 19609.0 19609.6 19696.5 46441.8 46866.8 47090.5 47156.0 48342.3 64405.7 67009.0 68543.0 69543.3 69612.7 9152.2 9247.1 9297.0 9399.4 9402.7 10173.7 12758.7 13163.0 13222.9 13308.1 10825.2 10989.8 11032.9 11122.4 11438.4 9792.6 10873.2 11007.3 11572.5 11642.1 11417.9 11501.6 11590.2 11604.5 11959.5 8807.6 8890.4 8930.6 9089.2 9111.5 10002.5 10600.7 11303.7 11531.5 11589.5 17:44:45 INFO - PROCESS | 9141 | 17:44:45 INFO - PROCESS | 9141 | [#3] mootools.html Cycles:180 Average:5880.68 Median:5034.65 stddev:3330.97 (66.2%) stddev-sans-first:3323.73 17:44:45 INFO - PROCESS | 9141 | Values: 1457.8 1483.3 1492.7 1501.9 1520.2 8634.3 8781.7 9149.0 9172.6 9228.1 9078.7 9144.3 9193.0 9235.5 9326.3 2367.6 2407.4 2408.9 2410.5 2422.4 2412.5 2430.1 2431.8 2451.3 2457.6 2348.0 2367.0 2367.2 2374.3 2397.8 2330.1 2332.1 2344.7 2356.1 2361.3 2312.2 2314.2 2375.2 2375.4 2381.7 9095.9 9221.0 9236.4 9250.9 9271.5 5441.3 5503.8 5566.5 5568.9 5582.2 3430.4 3455.4 3538.7 3611.8 3686.9 1462.2 1472.6 1481.4 1494.1 1522.2 12362.8 12476.9 12547.5 12588.9 12655.0 4498.6 4599.8 4714.1 4720.8 4726.1 10104.9 10156.7 10163.4 10179.0 10190.7 5553.4 5557.1 5561.9 5562.9 5571.0 4539.7 4678.2 4998.7 5021.4 5047.8 3977.2 4054.5 4100.3 4155.0 4178.7 1138.8 1140.9 1154.3 1157.9 1162.0 878.5 883.5 886.4 903.9 912.0 5888.2 5959.0 5985.8 6073.9 6109.1 636.7 651.6 654.5 655.9 665.6 3851.9 3862.6 3878.7 3884.4 3900.0 10644.4 10969.9 10985.4 11010.5 11018.3 10576.5 10804.9 10927.9 10931.9 10999.3 8236.8 8311.8 8361.2 8397.0 8466.1 5861.4 5911.6 5938.3 6043.5 6063.6 9775.3 9914.9 10058.6 10155.5 10253.3 9688.4 10076.9 10102.5 10106.1 10567.4 7681.3 7963.3 8080.1 8161.9 8315.9 8858.9 8904.4 8935.3 8952.0 8966.9 7623.7 7751.6 7885.1 7935.9 7954.6 7325.7 7362.0 7369.5 7460.7 7588.0 6497.5 6731.5 6770.7 6795.2 6841.0 5343.0 5354.9 5400.1 5412.7 5457.2 5266.4 5347.2 5367.7 5373.7 5377.1 17:44:45 INFO - PROCESS | 9141 | 17:44:45 INFO - PROCESS | 9141 | [#4] prototype.html Cycles:180 Average:4906.01 Median:5539.68 stddev:1431.65 (25.8%) stddev-sans-first:1394.66 17:44:45 INFO - PROCESS | 9141 | Values: 373.7 395.1 397.7 397.9 405.2 5363.4 5454.8 5501.2 5676.5 5695.3 5396.1 5519.9 5535.7 5537.0 5542.4 4414.4 4445.0 4448.1 4453.3 4486.3 4365.3 4398.6 4420.7 4462.2 4478.4 4334.0 4349.4 4361.7 4367.6 4391.4 4362.5 4373.4 4379.8 4387.3 4412.2 3603.3 3925.4 3927.0 3934.7 3953.3 5313.9 5348.7 5381.7 5382.7 5389.5 4929.4 4943.7 4957.6 4961.3 4961.8 5546.8 5740.7 5753.6 5778.3 5780.3 4156.3 4170.0 4175.5 4181.8 4182.0 5999.3 6009.8 6010.5 6010.6 6027.8 4216.3 4271.9 4288.1 4289.6 4332.0 4327.9 4368.2 4370.8 4379.4 4399.5 4976.9 4982.4 4990.4 4996.0 5012.2 5652.9 5694.9 5719.8 5752.5 5813.0 1417.8 1453.0 1453.1 1458.4 1460.9 984.6 984.7 1011.9 1018.2 1023.0 5468.5 5478.8 5490.6 5498.5 5501.6 5750.9 5782.2 5802.2 5814.3 5833.6 5549.7 5588.6 5630.7 5655.2 5726.8 3038.0 3058.4 3065.6 3071.8 3078.5 5939.5 6003.3 6012.7 6033.8 6059.5 6101.1 6132.6 6138.3 6144.0 6172.5 6225.8 6309.9 6309.9 6321.4 6324.8 5898.3 5965.0 6002.4 6016.9 6024.7 5906.8 5940.3 5967.8 5976.4 5983.3 6128.7 6160.5 6182.2 6201.1 6267.7 4229.6 4270.0 4282.9 4294.7 4301.0 5784.0 5890.7 5932.8 5972.0 5995.9 5748.8 5784.7 5786.7 5798.6 5800.8 5792.2 5816.8 5846.6 5847.6 5874.8 5637.0 5787.9 5830.8 5841.2 5844.4 5778.2 5833.6 5850.7 5856.4 5875.5 5473.3 5678.8 5706.5 5734.7 5744.8 17:44:45 INFO - PROCESS | 9141 | 17:44:45 INFO - PROCESS | 9141 | [#5] yui.html Cycles:180 Average:18005.12 Median:23608.70 stddev:21879.43 (92.7%) stddev-sans-first:21902.77 17:44:45 INFO - PROCESS | 9141 | Values: 826.8 834.3 840.5 908.1 945.5 15557.8 15774.0 15936.8 15970.7 16356.3 16055.0 16059.6 16288.7 16308.2 16381.0 840.5 852.6 854.8 855.4 856.5 799.7 845.3 846.0 852.3 853.7 874.0 878.0 879.5 884.2 884.6 882.1 882.5 883.2 884.4 885.5 643.5 647.8 648.3 649.3 650.0 16046.9 16147.3 17058.6 17772.7 17815.9 14216.3 14542.0 14556.3 14738.0 14978.6 13149.3 13285.7 13290.3 13348.3 13411.7 3964.6 3986.1 3988.7 4028.6 4056.4 80455.2 81216.2 82027.0 82095.0 82912.0 11925.8 12055.9 12090.6 12120.8 12170.3 23838.8 23897.6 24225.2 24570.3 24776.1 8555.0 8636.8 8737.2 8739.0 8806.2 4737.5 4835.6 4879.8 4887.9 4896.8 3990.5 4004.7 4034.4 4075.2 4094.0 659.4 665.7 669.4 669.7 670.4 656.7 661.7 671.5 673.2 679.4 10140.5 10892.7 11234.6 11346.5 11377.4 695.2 700.5 702.1 702.2 887.3 5271.4 5547.3 5586.8 5592.1 5706.1 67748.7 68103.0 69632.0 71851.3 79414.0 59749.0 69152.3 69584.3 70139.0 70216.3 56960.4 62253.9 62845.7 64166.7 64647.4 11421.0 11516.4 11658.0 11919.2 12085.4 36998.0 43123.4 43607.8 43608.3 44671.0 52495.5 54596.2 54849.2 55078.7 56497.4 13284.1 13525.9 13541.7 13595.8 13633.7 15324.5 15466.7 15560.5 15641.6 15740.6 14012.5 14179.5 14279.0 14279.1 14506.3 14992.9 15243.8 15252.0 15670.9 15910.1 14533.6 14630.3 14732.3 14984.8 15090.1 11791.6 11874.5 11877.2 11933.8 12274.6 12014.4 12386.1 12404.9 12411.8 12464.1 17:44:45 INFO - PROCESS | 9141 | -------- Summary: end -------- 17:44:45 INFO - PROCESS | 9141 | 17:44:46 INFO - TEST-INFO | 9141: exit 0 17:44:46 INFO - TEST-OK | dromaeo_css | took 1112559ms 17:44:46 INFO - TEST-START | kraken 17:44:46 INFO - operating with platform_type : linux_ 17:44:46 INFO - Initialising browser for kraken test... 17:44:46 INFO - TEST-INFO | started process 9510 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUu9zYu/profile http://localhost:52207/getInfo.html) 17:44:50 INFO - PROCESS | 9510 | __metrics Screen width/height:1600/1200 17:44:50 INFO - PROCESS | 9510 | colorDepth:24 17:44:50 INFO - PROCESS | 9510 | Browser inner width/height: 1024/697 17:44:50 INFO - PROCESS | 9510 | __metrics 17:44:51 INFO - PROCESS | 9510 | 1486691091083 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/tmpUu9zYu/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpUu9zYu/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpUu9zYu/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpUu9zYu/profile/extensions/talos-powers@TalosPowersService.js:55:9 17:44:51 ERROR - PROCESS | 9510 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3280: TypeError: this.tabs is undefined 17:44:51 INFO - TEST-INFO | 9510: exit 0 17:44:51 INFO - Browser initialized. 17:44:51 INFO - Running cycle 1/1 for kraken test... 17:44:51 INFO - TEST-INFO | started process 9639 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUu9zYu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:45:03 INFO - PROCESS | 9639 | RSS: Main: 144793600 17:45:03 INFO - PROCESS | 9639 | 17:45:06 INFO - PROCESS | 9639 | Cycle 1(1): loaded http://localhost:52207/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52207/tests/kraken/driver.html?testName=audio-beat-detection) 17:45:07 INFO - PROCESS | 9639 | RSS: Main: 151523328 17:45:07 INFO - PROCESS | 9639 | 17:45:09 INFO - PROCESS | 9639 | Cycle 1(1): loaded http://localhost:52207/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52207/tests/kraken/driver.html?testName=audio-dft) 17:45:10 INFO - PROCESS | 9639 | RSS: Main: 150163456 17:45:10 INFO - PROCESS | 9639 | 17:45:13 INFO - PROCESS | 9639 | Cycle 1(1): loaded http://localhost:52207/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52207/tests/kraken/driver.html?testName=audio-fft) 17:45:14 INFO - PROCESS | 9639 | RSS: Main: 150351872 17:45:14 INFO - PROCESS | 9639 | 17:45:16 INFO - PROCESS | 9639 | Cycle 1(1): loaded http://localhost:52207/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52207/tests/kraken/driver.html?testName=audio-oscillator) 17:45:16 INFO - PROCESS | 9639 | RSS: Main: 150327296 17:45:16 INFO - PROCESS | 9639 | 17:45:18 INFO - PROCESS | 9639 | Cycle 1(1): loaded http://localhost:52207/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52207/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:45:19 INFO - PROCESS | 9639 | RSS: Main: 150188032 17:45:19 INFO - PROCESS | 9639 | 17:45:22 INFO - PROCESS | 9639 | Cycle 1(1): loaded http://localhost:52207/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52207/tests/kraken/driver.html?testName=imaging-darkroom) 17:45:23 INFO - PROCESS | 9639 | RSS: Main: 152936448 17:45:23 INFO - PROCESS | 9639 | 17:45:26 INFO - PROCESS | 9639 | Cycle 1(1): loaded http://localhost:52207/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52207/tests/kraken/driver.html?testName=imaging-desaturate) 17:45:27 INFO - PROCESS | 9639 | RSS: Main: 153628672 17:45:27 INFO - PROCESS | 9639 | 17:45:29 INFO - PROCESS | 9639 | Cycle 1(1): loaded http://localhost:52207/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52207/tests/kraken/driver.html?testName=json-parse-financial) 17:45:30 INFO - PROCESS | 9639 | RSS: Main: 152621056 17:45:30 INFO - PROCESS | 9639 | 17:45:32 INFO - PROCESS | 9639 | Cycle 1(1): loaded http://localhost:52207/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52207/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:45:32 INFO - PROCESS | 9639 | RSS: Main: 152121344 17:45:32 INFO - PROCESS | 9639 | 17:45:34 INFO - PROCESS | 9639 | Cycle 1(1): loaded http://localhost:52207/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52207/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:45:35 INFO - PROCESS | 9639 | RSS: Main: 153399296 17:45:35 INFO - PROCESS | 9639 | 17:45:37 INFO - PROCESS | 9639 | Cycle 1(1): loaded http://localhost:52207/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52207/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:45:37 INFO - PROCESS | 9639 | RSS: Main: 152543232 17:45:37 INFO - PROCESS | 9639 | 17:45:40 INFO - PROCESS | 9639 | Cycle 1(1): loaded http://localhost:52207/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52207/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:45:41 INFO - PROCESS | 9639 | RSS: Main: 153300992 17:45:41 INFO - PROCESS | 9639 | 17:45:43 INFO - PROCESS | 9639 | Cycle 1(1): loaded http://localhost:52207/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52207/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:45:44 INFO - PROCESS | 9639 | RSS: Main: 152891392 17:45:44 INFO - PROCESS | 9639 | 17:45:46 INFO - PROCESS | 9639 | Cycle 1(1): loaded http://localhost:52207/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52207/tests/kraken/driver.html?testName=ai-astar) 17:45:46 INFO - PROCESS | 9639 | RSS: Main: 155045888 17:45:46 INFO - PROCESS | 9639 | 17:45:46 INFO - PROCESS | 9639 | __start_tp_report 17:45:46 INFO - PROCESS | 9639 | _x_x_mozilla_page_load 17:45:46 INFO - PROCESS | 9639 | _x_x_mozilla_page_load_details 17:45:46 INFO - PROCESS | 9639 | |i|pagename|runs| 17:45:46 INFO - PROCESS | 9639 | |0;ai-astar;103;112;113;113;113;113;113;112;114;115 17:45:46 INFO - PROCESS | 9639 | |1;audio-beat-detection;145;122;119;158;126;117;117;123;140;117 17:45:46 INFO - PROCESS | 9639 | |2;audio-dft;162;162;163;160;159;163;165;161;161;160 17:45:46 INFO - PROCESS | 9639 | |3;audio-fft;75;76;76;114;76;75;76;74;93;75 17:45:46 INFO - PROCESS | 9639 | |4;audio-oscillator;82;83;108;85;83;83;93;84;83;102 17:45:46 INFO - PROCESS | 9639 | |5;imaging-gaussian-blur;118;119;117;119;117;117;117;117;118;117 17:45:46 INFO - PROCESS | 9639 | |6;imaging-darkroom;148;147;146;148;148;147;147;147;148;147 17:45:46 INFO - PROCESS | 9639 | |7;imaging-desaturate;97;95;96;96;97;96;96;101;97;96 17:45:46 INFO - PROCESS | 9639 | |8;json-parse-financial;55;56;55;55;58;56;57;58;55;57 17:45:46 INFO - PROCESS | 9639 | |9;json-stringify-tinderbox;64;64;64;65;65;64;65;65;64;63 17:45:46 INFO - PROCESS | 9639 | |10;stanford-crypto-aes;78;77;76;79;78;75;76;76;78;77 17:45:46 INFO - PROCESS | 9639 | |11;stanford-crypto-ccm;123;126;131;122;138;129;130;121;175;128 17:45:46 INFO - PROCESS | 9639 | |12;stanford-crypto-pbkdf2;159;163;158;160;159;161;159;161;163;159 17:45:46 INFO - PROCESS | 9639 | |13;stanford-crypto-sha256-iterative;62;62;65;60;62;60;61;63;66;63 17:45:46 INFO - PROCESS | 9639 | __end_tp_report 17:45:46 INFO - PROCESS | 9639 | __start_cc_report 17:45:46 INFO - PROCESS | 9639 | _x_x_mozilla_cycle_collect,702 17:45:46 INFO - PROCESS | 9639 | __end_cc_report 17:45:46 INFO - PROCESS | 9639 | __startTimestamp1486691146340__endTimestamp 17:45:46 INFO - PROCESS | 9639 | 17:45:46 INFO - PROCESS | 9639 | ------- Summary: start ------- 17:45:46 INFO - PROCESS | 9639 | Number of tests: 14 17:45:46 INFO - PROCESS | 9639 | 17:45:46 INFO - PROCESS | 9639 | [#0] ai-astar Cycles:10 Average:112.10 Median:113.00 stddev:3.31 (2.9%) stddev-sans-first:0.93 17:45:46 INFO - PROCESS | 9639 | Values: 103.0 112.0 113.0 113.0 113.0 113.0 113.0 112.0 114.0 115.0 17:45:46 INFO - PROCESS | 9639 | 17:45:46 INFO - PROCESS | 9639 | [#1] audio-beat-detection Cycles:10 Average:128.40 Median:124.50 stddev:14.30 (11.5%) stddev-sans-first:13.85 17:45:46 INFO - PROCESS | 9639 | Values: 145.0 122.0 119.0 158.0 126.0 117.0 117.0 123.0 140.0 117.0 17:45:46 INFO - PROCESS | 9639 | 17:45:46 INFO - PROCESS | 9639 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.78 (1.1%) stddev-sans-first:1.88 17:45:46 INFO - PROCESS | 9639 | Values: 162.0 162.0 163.0 160.0 159.0 163.0 165.0 161.0 161.0 160.0 17:45:46 INFO - PROCESS | 9639 | 17:45:46 INFO - PROCESS | 9639 | [#3] audio-fft Cycles:10 Average:81.00 Median:76.00 stddev:12.87 (16.9%) stddev-sans-first:13.46 17:45:46 INFO - PROCESS | 9639 | Values: 75.0 76.0 76.0 114.0 76.0 75.0 76.0 74.0 93.0 75.0 17:45:46 INFO - PROCESS | 9639 | 17:45:46 INFO - PROCESS | 9639 | [#4] audio-oscillator Cycles:10 Average:88.60 Median:83.00 stddev:9.30 (11.2%) stddev-sans-first:9.55 17:45:46 INFO - PROCESS | 9639 | Values: 82.0 83.0 108.0 85.0 83.0 83.0 93.0 84.0 83.0 102.0 17:45:46 INFO - PROCESS | 9639 | 17:45:46 INFO - PROCESS | 9639 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:117.50 stddev:0.84 (0.7%) stddev-sans-first:0.88 17:45:46 INFO - PROCESS | 9639 | Values: 118.0 119.0 117.0 119.0 117.0 117.0 117.0 117.0 118.0 117.0 17:45:46 INFO - PROCESS | 9639 | 17:45:46 INFO - PROCESS | 9639 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.67 (0.5%) stddev-sans-first:0.67 17:45:46 INFO - PROCESS | 9639 | Values: 148.0 147.0 146.0 148.0 148.0 147.0 147.0 147.0 148.0 147.0 17:45:46 INFO - PROCESS | 9639 | 17:45:46 INFO - PROCESS | 9639 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:96.00 stddev:1.64 (1.7%) stddev-sans-first:1.73 17:45:46 INFO - PROCESS | 9639 | Values: 97.0 95.0 96.0 96.0 97.0 96.0 96.0 101.0 97.0 96.0 17:45:46 INFO - PROCESS | 9639 | 17:45:46 INFO - PROCESS | 9639 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.50 stddev:1.23 (2.2%) stddev-sans-first:1.22 17:45:46 INFO - PROCESS | 9639 | Values: 55.0 56.0 55.0 55.0 58.0 56.0 57.0 58.0 55.0 57.0 17:45:46 INFO - PROCESS | 9639 | 17:45:46 INFO - PROCESS | 9639 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 17:45:46 INFO - PROCESS | 9639 | Values: 64.0 64.0 64.0 65.0 65.0 64.0 65.0 65.0 64.0 63.0 17:45:46 INFO - PROCESS | 9639 | 17:45:46 INFO - PROCESS | 9639 | [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:77.50 stddev:1.25 (1.6%) stddev-sans-first:1.27 17:45:46 INFO - PROCESS | 9639 | Values: 78.0 77.0 76.0 79.0 78.0 75.0 76.0 76.0 78.0 77.0 17:45:46 INFO - PROCESS | 9639 | 17:45:46 INFO - PROCESS | 9639 | [#11] stanford-crypto-ccm Cycles:10 Average:132.30 Median:129.50 stddev:15.82 (12.2%) stddev-sans-first:16.42 17:45:46 INFO - PROCESS | 9639 | Values: 123.0 126.0 131.0 122.0 138.0 129.0 130.0 121.0 175.0 128.0 17:45:46 INFO - PROCESS | 9639 | 17:45:46 INFO - PROCESS | 9639 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.20 Median:160.50 stddev:1.75 (1.1%) stddev-sans-first:1.80 17:45:46 INFO - PROCESS | 9639 | Values: 159.0 163.0 158.0 160.0 159.0 161.0 159.0 161.0 163.0 159.0 17:45:46 INFO - PROCESS | 9639 | 17:45:46 INFO - PROCESS | 9639 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.40 Median:62.50 stddev:1.96 (3.1%) stddev-sans-first:2.07 17:45:46 INFO - PROCESS | 9639 | Values: 62.0 62.0 65.0 60.0 62.0 60.0 61.0 63.0 66.0 63.0 17:45:46 INFO - PROCESS | 9639 | -------- Summary: end -------- 17:45:46 INFO - PROCESS | 9639 | 17:45:47 INFO - TEST-INFO | 9639: exit 0 17:45:47 INFO - TEST-OK | kraken | took 61256ms 17:45:47 INFO - SUITE-END | took 1173s 17:45:47 INFO - Completed test suite (00:19:33) 17:45:47 INFO - javascript benchmark 17:45:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7599.225015135775, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3245.448273793455, 3369.7135743461813, 3383.4079036168664, 3390.2033022239752, 3394.2532642818587, 5610.467005634463, 5661.0, 5661.915071273929, 5676.091825307952, 5681.886362272752, 5625.353084395296, 5672.347680016799, 5688.459596338352, 5695.886082278352, 5728.656280623155, 5174.197999310103, 5174.353205849269, 5205.661631993928, 5221.39953905302, 5273.182656688219, 5249.1338929076655, 5249.370075590915, 5259.421463638997, 5275.446078161795, 5278.947210527903, 5096.464871188509, 5098.490150984909, 5235.869103272411, 5237.79048838046, 5286.841394758163, 5112.10538155825, 5149.021685879671, 5184.818531351385, 5188.662736922107, 5218.2172674099, 5057.49425057495, 5189.325387699612, 5190.4031036430915, 5214.165733482625, 5246.973765131188, 5640.492355687967, 5682.40334764852, 5694.572907031989, 5696.829095127111, 5704.344000439961, 5884.705764711747, 5891.440313170242, 5933.703314834284, 5953.970230148865, 6058.545609079292, 5998.700064996733, 6022.457978781887, 6035.185249991283, 6048.123022161806, 6066.696665166724, 5609.214709940612, 5616.550675945915, 5621.7751289948355, 5622.803201887955, 5643.887122257573, 5890.204822348928, 6011.068284415923, 6085.421884920926, 6097.878042439126, 6110.663913484712, 5915.911261331084, 5951.851203719942, 5974.133750606138, 6006.639601623917, 6017.819465416044, 6051.969740151271, 6056.121862329937, 6073.605215660968, 6082.878342433215, 6086.147939288503, 5828.300603927556, 5836.970815145982, 6040.033594624839, 6063.0, 6063.029915213545, 5935.6735379553675, 5936.990711579042, 5964.224650795369, 5990.5507086968655, 6044.758209671564, 4621.168189725814, 4625.121226966933, 4661.510541393172, 4662.277347011219, 4685.929711054337, 4095.610916962884, 4147.315692910636, 4163.208990291835, 4169.207850508394, 4183.247015537172, 5765.4811067004175, 5786.450287222707, 5789.739461724233, 5820.505257053113, 5846.1523079153285, 6017.428344307284, 6033.456988870935, 6045.425684559959, 6064.0, 6071.0, 5615.0940399191695, 5678.119891416754, 5805.477507024304, 5806.506446951972, 5843.503302219274, 5136.1525348317855, 5151.7166555839785, 5175.792968281302, 5183.97408012965, 5221.947780522222, 6290.591111577733, 6305.558610897193, 6332.271788744261, 6340.8414789629705, 6355.428011478989, 5896.882062358814, 6149.600275982047, 6159.384061593805, 6161.199044124414, 6162.691865406622, 6135.355787642412, 6189.721462534287, 6199.814005579839, 6212.658303793335, 6262.34245404226, 5997.513056453618, 6024.487918526799, 6033.3061697905305, 6045.6070355426755, 6072.240969878765, 6049.485793707584, 6101.084837274267, 6101.816945491642, 6101.84745381369, 6117.571769976237, 5811.302643682785, 5853.180554722428, 5877.823665289877, 5903.734331954986, 5927.229460170322, 5940.346561878277, 5941.346451890375, 5948.821535353946, 5949.762009519571, 5951.494122999594, 5904.291485021825, 5927.347991720993, 5949.732262048305, 5955.76176952917, 5964.224650795369, 5770.192173095686, 5884.58807883444, 5898.94101058984, 5903.26209223847, 5940.108983652487, 5826.592138550261, 5835.620684655484, 5846.649201047951, 5871.412858714094, 5889.440503152194], "value": 5591.654218810449, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [526.0218695393704, 581.5260562641447, 599.2479438304928, 615.1818081951005, 630.2940706408823, 45743.0, 47736.76131619346, 48140.0, 53313.466865331335, 53497.0, 50044.749776251156, 51348.716282092966, 51401.485985140134, 51442.228366574534, 51573.0, 9298.256139508856, 9586.0, 9606.183474404685, 10469.947650261738, 10855.24013319068, 10883.18376121794, 10915.890841091606, 10995.560177592886, 11016.0, 11028.724281892937, 11058.502367393447, 11091.168162387854, 11092.057175140082, 11102.55589776408, 11173.050290725298, 10895.073918716918, 10972.670819875417, 11020.283681560713, 11071.114310855111, 11075.446227688624, 10359.63741269052, 10552.47237638115, 10597.0, 10602.363858168457, 10607.310524815863, 43413.34879976803, 43664.3450348245, 43738.78130609358, 43820.3426948596, 43842.0, 4253.064325848309, 4310.978445107754, 4342.564672274259, 4382.07976324969, 4387.122575484916, 32261.677383226102, 32673.183170420692, 32823.17942051444, 33002.0, 33037.66962330394, 4616.399868017136, 4721.032188401369, 4754.904901901978, 4766.594839438651, 4787.066522028206, 365489.0, 366788.0, 369502.0, 369537.0, 369610.0, 62673.0, 62687.0, 62845.0, 62895.0, 63246.68376658087, 64930.675346622964, 65331.346686532524, 65665.0, 65798.67100664465, 65808.0, 19054.14256358467, 19113.61772764537, 19276.32532861343, 19306.8069319305, 19318.806811931983, 13286.933565332305, 13789.793153102712, 14507.782383264259, 14757.631059223391, 14801.333939972727, 19472.844482660996, 19754.11106500211, 19862.801371986385, 19890.90054549718, 19934.0, 6951.93048069523, 7155.606441645656, 7174.457491639323, 7203.423726101899, 7276.599787011659, 960.5485421851719, 972.5866506734609, 974.28390133252, 979.7893452907659, 984.5618699678574, 33479.497807532905, 34084.1478963023, 34084.14789630279, 34085.0, 34246.0, 1175.7707247086908, 1187.329159025148, 1199.1545960098285, 1227.5826219085554, 1300.0379719008056, 17791.19939602721, 17840.19719112643, 17968.91015544914, 17997.37009204698, 18112.728309075374, 502852.0, 507098.0, 511039.0, 513065.0, 515253.0, 70067.64966175136, 70867.64566177136, 70997.0, 71105.28894711091, 71257.0, 1450.361840790049, 1481.9110853348618, 1496.7979322791284, 1508.4720347878374, 1519.01264178285, 32502.512462313556, 32826.0, 33363.999080027636, 33575.664243357256, 33635.831820840736, 58185.418145818, 59759.40240597539, 59815.40184598098, 59831.401685982586, 59924.700376497836, 371049.0, 372214.0, 372509.0, 372986.0, 374393.0, 30793.538096928114, 31658.683413165574, 31741.68258317387, 31796.68203317937, 31830.0, 47038.29442558296, 47301.0, 47517.28724069211, 48058.27912581384, 48621.756891215315, 39805.0, 40086.79956600198, 40851.18297633971, 40866.38700419437, 41926.79036604797, 39166.80416597899, 39509.2098158041, 39858.60141398549, 39896.0, 40437.39343909785, 40576.0, 40735.0, 40763.38854917238, 43964.78017609892, 45066.549334506235, 32464.675353246166, 34561.82719086489, 34803.65196348004, 34808.47787283243, 34906.825465872505, 27393.452130957667, 28099.57850632283, 28346.71653283441, 28366.29084272827, 28392.29019274452], "value": 21568.470985259246, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [429.5339556581109, 432.0710472484159, 437.9408779814726, 442.1554830274176, 449.6590333819718, 20313.289034883765, 20558.48603784904, 21799.891000545016, 21830.23594174204, 22016.229431969885, 20719.792802071974, 22444.214452494165, 22980.77019229807, 23049.078036878505, 23342.183023594178, 5992.37080106588, 6132.141500189977, 6152.200213972177, 6153.0, 6179.196704428418, 5941.138534912435, 6204.78283260086, 6254.562180647356, 6351.079093531435, 6362.077498762676, 5953.43442372976, 6058.969705151468, 6301.054841773725, 6315.98944168933, 6326.019466982625, 5982.820515384546, 6359.904601430982, 6379.744810207586, 6384.968075159641, 6393.264774550939, 5993.850153746148, 6064.484518815906, 6221.906671399933, 6234.438900498932, 6238.875222495525, 24261.393465163514, 24461.38846528833, 25097.874510627513, 25232.243032709048, 25280.620790688154, 2807.410443806803, 2922.722341377566, 2928.6485621725315, 2935.1781501179703, 2944.05790147153, 10997.010269075821, 11454.0, 11614.825777613343, 11965.820512692317, 16591.751123733153, 2003.7996200379991, 2039.367795983235, 2066.2045112631595, 2067.9379618611465, 2088.9164433422643, 93262.0, 93403.53298233465, 93503.0, 95394.0460595399, 96568.51715741376, 10513.0, 10830.133589312836, 11058.778824423627, 12045.0, 12678.366081695878, 14963.476278330207, 14983.925080374747, 15078.095314281178, 15100.471483498024, 15177.468788592567, 8765.649374025095, 8973.775655608531, 8982.640694372283, 9013.63945442175, 9049.185573298435, 9039.68361107358, 9061.13919177677, 9071.0, 9253.583588738524, 9326.160645541799, 4584.908301834012, 4596.172688916027, 4639.536046395334, 4657.883552911204, 4748.335233067304, 2059.124871929424, 2136.626090434168, 2144.721186245778, 2154.666026765854, 2165.8700477971374, 996.3673067602125, 998.1266391907081, 1001.439194051319, 1013.2552573858209, 1015.9593616255415, 20557.486062848548, 20740.377788666363, 20816.167353305696, 20908.30509990153, 20925.58148837045, 998.4109375468508, 1014.60937539048, 1022.2077889635443, 1031.376017509411, 1037.7872536130076, 11104.611338603272, 11416.714582135513, 11418.143639227092, 11496.597619083292, 11540.307581545134, 670282.0, 676821.2119092168, 689029.0, 694826.0, 728651.0, 85869.0, 86385.0, 110388.4480577608, 111644.44177779059, 111955.0, 1115.4478533126155, 1150.5742875136086, 1175.4416652090188, 1184.9703757405962, 1187.5724739093919, 19213.711794322815, 19332.710009350154, 19609.0, 19609.607807844048, 19696.507587310432, 46441.767791160826, 46866.76566617282, 47090.52909470862, 47156.0, 48342.27486587774, 64405.67797160984, 67009.0, 68543.0, 69543.30456695368, 69612.65193673999, 9152.22206112488, 9247.0752924707, 9297.0, 9399.389039712396, 9402.670906518239, 10173.694789156338, 12758.68103297425, 13163.012774041794, 13222.867771322164, 13308.068435209443, 10825.242233043611, 10989.835152472879, 11032.944835275772, 11122.388268644978, 11438.428078596204, 9792.559334830092, 10873.238873278795, 11007.284526505751, 11572.537098515964, 11642.068634509389, 11417.885821141683, 11501.597444089417, 11590.246633968765, 11604.535818567163, 11959.461824217757, 8807.559622019002, 8890.377673562789, 8930.598123084606, 9089.227415669478, 9111.498867562348, 10002.499875006366, 10600.681979540317, 11303.717407064889, 11531.481083351437, 11589.536418543164], "value": 9985.6707841075, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1457.7813328000805, 1483.2583708145928, 1492.67907399909, 1501.9098854068754, 1520.2398800599701, 8634.309255259579, 8781.692640757576, 9148.954255228715, 9172.633094676214, 9228.077192280769, 9078.682246121387, 9144.268458523318, 9192.98877123516, 9235.492047937361, 9326.347155699104, 2367.573836709392, 2407.3861165402886, 2408.915687950922, 2410.4937963027696, 2422.358075110097, 2412.517496500698, 2430.1251549442186, 2431.8297719159664, 2451.264620613809, 2457.6436416719566, 2347.9882600586975, 2367.029517897662, 2367.230650038736, 2374.252110585169, 2397.7602239776056, 2330.0912644068826, 2332.102140675835, 2344.7069116360453, 2356.1400088967575, 2361.2562042956415, 2312.167619656922, 2314.2478694424212, 2375.1924345722364, 2375.4417711837705, 2381.749916258785, 9095.863562046574, 9221.031791661846, 9236.353455258135, 9250.90749092514, 9271.490068046254, 5441.319835020622, 5503.807366742185, 5566.526845218162, 5568.9443105569235, 5582.190582365534, 3430.4168291390524, 3455.4125798614295, 3538.7345949053924, 3611.783293002402, 3686.9262614747554, 1462.2104063805532, 1472.646564824445, 1481.4148411377553, 1494.0736743219275, 1522.216058729755, 12362.75274494505, 12476.937615311865, 12547.498100075985, 12588.937055314756, 12655.0, 4498.617617502484, 4599.816007359668, 4714.104320179155, 4720.834770783006, 4726.125666751662, 10104.949475252724, 10156.746081348025, 10163.390196588229, 10179.0, 10190.694279171637, 5553.361363443175, 5557.083081291623, 5561.916571251434, 5562.9443705563235, 5571.0, 4539.72761634303, 4678.1813182692895, 4998.650094493423, 5021.447640759514, 5047.848564543069, 3977.1846771411792, 4054.5134583850127, 4100.261952848516, 4155.0, 4178.7283826551175, 1138.8007098757685, 1140.9030232430337, 1154.261272785418, 1157.8784227656142, 1162.023899924051, 878.5255961780695, 883.5273128876021, 886.3972498700816, 903.8734577159072, 911.9772005699778, 5888.205092312569, 5959.0, 5985.760569577168, 6073.878522429527, 6109.14471973924, 636.6593872278308, 651.5732195412013, 654.5287393076977, 655.9016147577902, 665.6006396162264, 3851.8651847185215, 3862.5558060822805, 3878.728489005799, 3884.3784994401326, 3900.0054985978395, 10644.414557199274, 10969.945150274198, 10985.39580323074, 11010.50452729629, 11018.283811552223, 10576.471176441148, 10804.945975270231, 10927.890721092846, 10931.945340273247, 10999.34003959765, 8236.83526329482, 8311.750647480585, 8361.163883611713, 8396.992360916607, 8466.111058338909, 5861.443162899518, 5911.556633252438, 5938.287405511366, 6043.486303664238, 6063.605865618721, 9775.266854986046, 9914.859791123825, 10058.647947321808, 10155.492225388849, 10253.33353332031, 9688.370255933341, 10076.949615251877, 10102.494875256061, 10106.090451859369, 10567.365958042543, 7681.270279323456, 7963.323117534843, 8080.070791858776, 8161.877571836546, 8315.916840831756, 8858.867116993379, 8904.376693631642, 8935.28517718568, 8952.0, 8966.910330896608, 7623.733169339046, 7751.612419379121, 7885.053793544811, 7935.920640793518, 7954.5624990626075, 7325.706971721072, 7361.963190184015, 7369.484136110421, 7460.738874139379, 7587.962060189664, 6497.480201583957, 6731.461483081243, 6770.729170833111, 6795.218549866829, 6841.042254084532, 5343.011542864582, 5354.866128346823, 5400.081986062457, 5412.729363531729, 5457.20870473787, 5266.368035835724, 5347.224652425299, 5367.731613419392, 5373.650712703662, 5377.112776391851], "value": 4671.351026205303, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.65436970802, 395.1188848867028, 397.6957627415028, 397.87069202509184, 405.1512082187816, 5363.383210930744, 5454.781808727646, 5501.174823776436, 5676.489115979561, 5695.288088988877, 5396.136618141099, 5519.896020795847, 5535.675016493073, 5537.0, 5542.362628297747, 4414.381986521889, 4444.97765513932, 4448.132614140244, 4453.28747400416, 4486.327050942368, 4365.257906155945, 4398.560143985608, 4420.734755914639, 4462.174497717932, 4478.395416618763, 4334.0, 4349.369341445488, 4361.716488428242, 4367.585079417466, 4391.429114215148, 4362.541933097027, 4373.431453910987, 4379.8467053653285, 4387.319965405367, 4412.249587850333, 3603.3333833240936, 3925.3523168677134, 3926.959355770723, 3934.6852251819787, 3953.327934251184, 5313.893722125575, 5348.705821179834, 5381.704006279653, 5382.6770393776105, 5389.461053894618, 4929.408470983469, 4943.6539442239055, 4957.5786058185095, 4961.330220420269, 4961.824432363291, 5546.805861794858, 5740.741666625012, 5753.597248192586, 5778.3354914184565, 5780.265920223958, 4156.334986402191, 4170.0, 4175.498940127174, 4181.811818468176, 4181.958180418187, 5999.250093738283, 6009.819705408845, 6010.519158467312, 6010.609310394811, 6027.819165425044, 4216.262154123077, 4271.914561708749, 4288.099499105223, 4289.6139347458875, 4331.960329520955, 4327.870163895088, 4368.170047690928, 4370.847020354272, 4379.3649920761945, 4399.5160532341415, 4976.925346119811, 4982.434046466073, 4990.351254336913, 4995.9508503214, 5012.1980483122525, 5652.91915905824, 5694.857628559319, 5719.799807006818, 5752.511036561939, 5812.9536683396545, 1417.8015077889104, 1453.0, 1453.0700351774872, 1458.4457905995653, 1460.8831293496494, 984.5963155106515, 984.7193549838405, 1011.868457100587, 1018.1701912940929, 1022.9693109206736, 5468.48049435311, 5478.808241711601, 5490.615656903979, 5498.45015498455, 5501.614886957875, 5750.9360768258, 5782.190493330937, 5802.21670074543, 5814.331351894586, 5833.591648584558, 5549.694766787866, 5588.552915766729, 5630.690312032795, 5655.236543066716, 5726.770929162787, 3038.0252835656556, 3058.357744873557, 3065.6167979002626, 3071.800332978349, 3078.5074388097796, 5939.524838012949, 6003.309619393738, 6012.699365031731, 6033.7586496540525, 6059.484943779828, 6101.145839582462, 6132.5707200495535, 6138.324784273726, 6143.96928015366, 6172.475339596184, 6225.750969961241, 6309.936900631027, 6309.936900631027, 6321.399467050623, 6324.810255692337, 5898.292204935436, 5965.0, 6002.369751176238, 6016.909746353896, 6024.728887199999, 5906.822795316148, 5940.316863560746, 5967.836271926933, 5976.372480889618, 5983.277608687949, 6128.693565321627, 6160.507159427325, 6182.165407669907, 6201.131841542097, 6267.717952692049, 4229.598188172119, 4269.996550810619, 4282.850100246476, 4294.656427485731, 4300.967767735783, 5784.0, 5890.676012819336, 5932.79235226765, 5971.970140149271, 5995.850103747442, 5748.827535173951, 5784.652920824764, 5786.681732504752, 5798.578838485314, 5800.8259752207505, 5792.160136780059, 5816.782832446443, 5846.5615078870105, 5847.590668653153, 5874.794382196603, 5636.960684133824, 5787.94212057874, 5830.766769329349, 5841.240638716939, 5844.444777746107, 5778.16216648592, 5833.562482813891, 5850.736716847667, 5856.443637854397, 5875.471207591338, 5473.343198816167, 5678.77284908599, 5706.457886500776, 5734.684592347461, 5744.770209191753], "value": 4460.459380559449, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [826.7519744076775, 834.3450391442718, 840.4915026409022, 908.1191244492842, 945.498885590637, 15557.766633500492, 15774.0, 15936.760948585752, 15970.68058638828, 16356.345746170155, 16055.0, 16059.598510037255, 16288.674226515463, 16308.184590770474, 16381.0, 840.4621042532784, 852.5566705313233, 854.8033952191, 855.3713020929612, 856.4604299291469, 799.7440818937943, 845.2941793602319, 845.9703910363138, 852.3394369363762, 853.6841368693592, 874.021096372061, 878.0341624213378, 879.4503435352905, 884.2174675412274, 884.5798245833242, 882.095851751953, 882.4925667741043, 883.1609970528024, 884.4472204871987, 885.4642941020654, 643.5237923936301, 647.841278886671, 648.3095503289029, 649.3052433895733, 650.0314531348257, 16046.919765401215, 16147.273372698257, 17058.573535661584, 17772.733408998876, 17815.910920445316, 14216.289185540682, 14542.0, 14556.272186390637, 14738.0, 14978.62553436162, 13149.342532873414, 13285.667858303523, 13290.26903520306, 13348.2658453785, 13411.664708382272, 3964.5638979712207, 3986.123052928351, 3988.68090552758, 4028.617281358266, 4056.4320995060716, 80455.19544804536, 81216.18783812145, 82027.0, 82095.0, 82912.0, 11925.821112683318, 12055.939720301518, 12090.637280881587, 12120.81818772719, 12170.269783812999, 23838.761612383652, 23897.641535376635, 24225.15211967608, 24570.262892113264, 24776.132835351036, 8554.957225213959, 8636.827263454821, 8737.21365077146, 8739.038705742363, 8806.20744133031, 4737.526247375304, 4835.588974937099, 4879.804807807648, 4887.877803054952, 4896.804127834918, 3990.4812374391145, 4004.6796256299426, 4034.35450327952, 4075.2257071156387, 4094.0379010932406, 659.3571268013649, 665.6505334699225, 669.397542212013, 669.7120238297579, 670.4234358451728, 656.7241758461457, 661.6526323680107, 671.4930227678071, 673.1719984419192, 679.3546131175403, 10140.543675534618, 10892.727681808019, 11234.550617975354, 11346.48940797666, 11377.431128443544, 695.2005194026808, 700.4851434195862, 702.1293595941098, 702.2100137345486, 887.2946007923587, 5271.42014378418, 5547.306586676666, 5586.832395028156, 5592.133219351007, 5706.115552089433, 67748.6612566934, 68103.0, 69632.0, 71851.28148718446, 79414.0, 59749.0, 69152.3084769146, 69584.3041569588, 70139.0, 70216.297837022, 56960.43039569634, 62253.905293815296, 62845.68577157085, 64166.6791666048, 64647.35352646413, 11421.0, 11516.424178791194, 11658.0, 11919.225250358699, 12085.39573021363, 36998.0, 43123.353149703406, 43607.78196108999, 43608.34587481254, 44671.0, 52495.47504525058, 54596.18105728338, 54849.177262341895, 55078.72460637671, 56497.43502565086, 13284.136531125447, 13525.932370338085, 13541.729165416833, 13595.796063058864, 13633.727325453634, 15324.540263792103, 15466.690666186838, 15560.492869888405, 15641.608959776097, 15740.60648483797, 14012.509562165274, 14179.503717369842, 14279.0, 14279.143251404948, 14506.274686265433, 14992.925035374754, 15243.771343429635, 15252.0, 15670.921645392156, 15910.12494312824, 14533.636659083608, 14630.304711336377, 14732.263386830402, 14984.775228371365, 15090.094594324375, 11791.646250612152, 11874.52501899949, 11877.168598198043, 11933.82099268529, 12274.570390036663, 12014.381304304545, 12386.132970691964, 12404.875951240372, 12411.751764964469, 12464.127511074137], "value": 7673.818255581166, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1485.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 113.0, 113.0, 113.0, 113.0, 113.0, 112.0, 114.0, 115.0], "value": 112.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 122.0, 119.0, 158.0, 126.0, 117.0, 117.0, 123.0, 140.0, 117.0], "value": 128.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 163.0, 160.0, 159.0, 163.0, 165.0, 161.0, 161.0, 160.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 114.0, 76.0, 75.0, 76.0, 74.0, 93.0, 75.0], "value": 81.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 108.0, 85.0, 83.0, 83.0, 93.0, 84.0, 83.0, 102.0], "value": 88.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 117.0, 119.0, 117.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 148.0, 148.0, 147.0, 147.0, 147.0, 148.0, 147.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 101.0, 97.0, 96.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 55.0, 55.0, 58.0, 56.0, 57.0, 58.0, 55.0, 57.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 65.0, 65.0, 64.0, 65.0, 65.0, 64.0, 63.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 77.0, 76.0, 79.0, 78.0, 75.0, 76.0, 76.0, 78.0, 77.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 126.0, 131.0, 122.0, 138.0, 129.0, 130.0, 121.0, 175.0, 128.0], "value": 132.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 163.0, 158.0, 160.0, 159.0, 161.0, 159.0, 161.0, 163.0, 159.0], "value": 160.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 65.0, 60.0, 62.0, 60.0, 61.0, 63.0, 66.0, 63.0], "value": 62.4, "unit": "score"}]}]} 17:45:47 INFO - Return code: 0 17:45:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:45:47 ERROR - # TBPL SUCCESS # 17:45:47 INFO - Running post-action listener: _resource_record_post_action 17:45:47 INFO - [mozharness: 2017-02-10 01:45:47.621720Z] Finished run-tests step (success) 17:45:47 INFO - Running post-run listener: _resource_record_post_run 17:45:47 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 0; Write bytes: 370692096; Read time: 0; Write time: 238860 17:45:47 INFO - TinderboxPrint: CPU usage
13.3% 17:45:47 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 17:45:47 INFO - TinderboxPrint: I/O write bytes / time
370,692,096 / 238,860 17:45:47 INFO - TinderboxPrint: CPU idle
8,240.1 (86.7%) 17:45:47 INFO - TinderboxPrint: CPU user
1,205.4 (12.7%) 17:45:47 INFO - TinderboxPrint: Swap in / out
0 / 0 17:45:47 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 118525952; Read time: 0; Write time: 103260 17:45:47 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 252166144; Read time: 0; Write time: 135600 17:45:48 INFO - Running post-run listener: _upload_blobber_files 17:45:48 INFO - Blob upload gear active. 17:45:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:45:48 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 17:45:48 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'] 17:45:48 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 17:45:48 INFO - (blobuploader) - INFO - Open directory for files ... 17:45:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:45:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:45:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:45:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:45:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:45:49 INFO - (blobuploader) - INFO - Done attempting. 17:45:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:45:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:45:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:45:50 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:45:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:45:50 INFO - (blobuploader) - INFO - Done attempting. 17:45:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:45:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:45:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:45:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:45:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:45:54 INFO - (blobuploader) - INFO - Done attempting. 17:45:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:45:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:45:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:45:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:45:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:45:55 INFO - (blobuploader) - INFO - Done attempting. 17:45:55 INFO - (blobuploader) - INFO - Iteration through files over. 17:45:55 INFO - Return code: 0 17:45:55 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:45:55 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:45:55 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/2b456de099d0044b4c8a583a7baf0717608370a22d375ec3dd332865298e2cf8f7d21095f42016c3ae8c8bba32a2637052a5a493f4f41beaf778c6359ce9589a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/bbbe5223198e7bcf78268ec23a0cb9e254b4135c011854bf34d4a8bf85d4f028003626cd8048cb65e5664f66c1d6e380de5097b6ebaa475b7abfb76a63465ed7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/33611be9805b994958c0d5f1c9d42cc062df8aa0efb94e8f55ee2d9c7c350d3357257f839177d1c7358ac64c0acb56fbed3e30dfee429a3c31232f079e9c28bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/0f6aa59a407b898f4787407e77d8f9ae154a051561072db7d99e54d03c147bdf5e2b46436938b0fd73ab4884f0992281f94f24289c9ea664aeaf1e472e1b61f3"} 17:45:55 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:45:55 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:45:55 INFO - Contents: 17:45:55 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/2b456de099d0044b4c8a583a7baf0717608370a22d375ec3dd332865298e2cf8f7d21095f42016c3ae8c8bba32a2637052a5a493f4f41beaf778c6359ce9589a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/bbbe5223198e7bcf78268ec23a0cb9e254b4135c011854bf34d4a8bf85d4f028003626cd8048cb65e5664f66c1d6e380de5097b6ebaa475b7abfb76a63465ed7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/33611be9805b994958c0d5f1c9d42cc062df8aa0efb94e8f55ee2d9c7c350d3357257f839177d1c7358ac64c0acb56fbed3e30dfee429a3c31232f079e9c28bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/0f6aa59a407b898f4787407e77d8f9ae154a051561072db7d99e54d03c147bdf5e2b46436938b0fd73ab4884f0992281f94f24289c9ea664aeaf1e472e1b61f3"} 17:45:55 INFO - Running post-run listener: copy_logs_to_upload_dir 17:45:55 INFO - Copying logs to upload dir... 17:45:55 INFO - mkdir: /builds/slave/test/build/upload/logs 17:45:55 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.495608 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2017-02-09 17:45:55.140323) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 17:45:55.144206) ========= 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=6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637 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/2b456de099d0044b4c8a583a7baf0717608370a22d375ec3dd332865298e2cf8f7d21095f42016c3ae8c8bba32a2637052a5a493f4f41beaf778c6359ce9589a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/bbbe5223198e7bcf78268ec23a0cb9e254b4135c011854bf34d4a8bf85d4f028003626cd8048cb65e5664f66c1d6e380de5097b6ebaa475b7abfb76a63465ed7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/33611be9805b994958c0d5f1c9d42cc062df8aa0efb94e8f55ee2d9c7c350d3357257f839177d1c7358ac64c0acb56fbed3e30dfee429a3c31232f079e9c28bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/0f6aa59a407b898f4787407e77d8f9ae154a051561072db7d99e54d03c147bdf5e2b46436938b0fd73ab4884f0992281f94f24289c9ea664aeaf1e472e1b61f3"} build_url:https://queue.taskcluster.net/v1/task/Tn4IGwBxS7669Hnno10MvQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011492 build_url: 'https://queue.taskcluster.net/v1/task/Tn4IGwBxS7669Hnno10MvQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/2b456de099d0044b4c8a583a7baf0717608370a22d375ec3dd332865298e2cf8f7d21095f42016c3ae8c8bba32a2637052a5a493f4f41beaf778c6359ce9589a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/bbbe5223198e7bcf78268ec23a0cb9e254b4135c011854bf34d4a8bf85d4f028003626cd8048cb65e5664f66c1d6e380de5097b6ebaa475b7abfb76a63465ed7", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/33611be9805b994958c0d5f1c9d42cc062df8aa0efb94e8f55ee2d9c7c350d3357257f839177d1c7358ac64c0acb56fbed3e30dfee429a3c31232f079e9c28bf", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora-Non-PGO/sha512/0f6aa59a407b898f4787407e77d8f9ae154a051561072db7d99e54d03c147bdf5e2b46436938b0fd73ab4884f0992281f94f24289c9ea664aeaf1e472e1b61f3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 17:45:55.169216) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 17:45:55.169540) ========= 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=6dbc10da6d83fee962c624be000001a8-1486689916.226286-393006637 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004431 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 17:45:55.252440) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 17:45:55.252759) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 17:45:55.253059) ========= ========= Total master_lag: 0.15 =========