builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-068 starttime: 1486127070.87 results: success (0) revision: 9f17a6fc04f9540ffe11d7ad4e22db5a37df6e23 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 05:04:30.865788) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-03 05:04:30.866206) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 05:04:30.866485) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-03 05:04:30.883087) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 05:04:30.883352) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-02-03 05:04:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 140M=0s 2017-02-03 05:04:31 (140 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.120039 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 05:04:31.016754) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 05:04:31.017078) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017516 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 05:04:31.066488) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 05:04:31.066835) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9f17a6fc04f9540ffe11d7ad4e22db5a37df6e23 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'python archiver_client.py mozharness --repo mozilla-central --rev 9f17a6fc04f9540ffe11d7ad4e22db5a37df6e23 --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=97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-02-03 05:04:31,447 truncating revision to first 12 chars 2017-02-03 05:04:31,447 Setting DEBUG logging. 2017-02-03 05:04:31,447 attempt 1/10 2017-02-03 05:04:31,447 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9f17a6fc04f9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-03 05:04:32,094 unpacking tar archive at: mozilla-central-9f17a6fc04f9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.977112 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 05:04:32.056681) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 05:04:32.057013) ========= script_repo_revision: 9f17a6fc04f9540ffe11d7ad4e22db5a37df6e23 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-03 05:04:32.057396) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 05:04:32.057683) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-03 05:04:32.065471) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-02-03 05:04:32.066009) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:04:32 INFO - MultiFileLogger online at 20170203 05:04:32 in /builds/slave/test 05:04:32 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 05:04:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:04:32 INFO - {'append_to_log': False, 05:04:32 INFO - 'base_work_dir': '/builds/slave/test', 05:04:32 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:04:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:04:32 INFO - 'branch': 'Firefox-Non-PGO', 05:04:32 INFO - 'buildbot_json_path': 'buildprops.json', 05:04:32 INFO - 'config_files': ('talos/linux_config.py',), 05:04:32 INFO - 'default_actions': ('clobber', 05:04:32 INFO - 'read-buildbot-config', 05:04:32 INFO - 'download-and-extract', 05:04:32 INFO - 'populate-webroot', 05:04:32 INFO - 'create-virtualenv', 05:04:32 INFO - 'install', 05:04:32 INFO - 'run-tests'), 05:04:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:04:32 INFO - 'download_minidump_stackwalk': True, 05:04:32 INFO - 'download_symbols': 'ondemand', 05:04:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:04:32 INFO - 'tooltool.py': '/tools/tooltool.py', 05:04:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:04:32 INFO - '/tools/misc-python/virtualenv.py')}, 05:04:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:04:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:04:32 INFO - 'installer_path': 'installer.exe', 05:04:32 INFO - 'log_level': 'info', 05:04:32 INFO - 'log_name': 'talos', 05:04:32 INFO - 'log_to_console': True, 05:04:32 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:04:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:04:32 INFO - 'opt_config_files': (), 05:04:32 INFO - 'pip_index': False, 05:04:32 INFO - 'sps_profile': False, 05:04:32 INFO - 'sps_profile_interval': 0, 05:04:32 INFO - 'suite': 'dromaeojs-e10s', 05:04:32 INFO - 'system_bits': '32', 05:04:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:04:32 INFO - 'title': 'talos-linux64-ix-068', 05:04:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:04:32 INFO - 'use_talos_json': True, 05:04:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:04:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:04:32 INFO - 'work_dir': 'build'} 05:04:32 INFO - [mozharness: 2017-02-03 13:04:32.551132Z] Running clobber step. 05:04:32 INFO - Running pre-action listener: _resource_record_pre_action 05:04:32 INFO - Running main action method: clobber 05:04:32 INFO - rmtree: /builds/slave/test/build 05:04:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:04:33 INFO - Running post-action listener: _resource_record_post_action 05:04:33 INFO - [mozharness: 2017-02-03 13:04:33.018937Z] Finished clobber step (success) 05:04:33 INFO - [mozharness: 2017-02-03 13:04:33.019038Z] Running read-buildbot-config step. 05:04:33 INFO - Running pre-action listener: _resource_record_pre_action 05:04:33 INFO - Running main action method: read_buildbot_config 05:04:33 INFO - Using buildbot properties: 05:04:33 INFO - { 05:04:33 INFO - "project": "", 05:04:33 INFO - "product": "firefox", 05:04:33 INFO - "who": "cbook@mozilla.com", 05:04:33 INFO - "installer_path": "public/build/target.tar.bz2", 05:04:33 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 05:04:33 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 05:04:33 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 05:04:33 INFO - "stage_platform": "linux64", 05:04:33 INFO - "basedir": "/builds/slave/test", 05:04:33 INFO - "buildnumber": 682, 05:04:33 INFO - "platform": "ubuntu64_hw", 05:04:33 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:04:33 INFO - "slavebuilddir": "test", 05:04:33 INFO - "taskId": "I4okzX7nRfOl8AtKKqSKqw", 05:04:33 INFO - "branch": "mozilla-central", 05:04:33 INFO - "script_repo_revision": "production", 05:04:33 INFO - "revision": "9f17a6fc04f9540ffe11d7ad4e22db5a37df6e23", 05:04:33 INFO - "slavename": "talos-linux64-ix-068", 05:04:33 INFO - "repo_path": "mozilla-central" 05:04:33 INFO - } 05:04:33 INFO - Finding installer, test and symbols from parent task. 05:04:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I4okzX7nRfOl8AtKKqSKqw'}, attempt #1 05:04:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I4okzX7nRfOl8AtKKqSKqw'}, attempt #1 05:04:33 INFO - Task dependencies: JkCo8rXlRemHvB9foFDoPw 05:04:33 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw'}, attempt #1 05:04:34 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw/artifacts/public/build/target.tar.bz2 05:04:34 INFO - Set test_url: https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw/artifacts/public/build/test_packages.json 05:04:34 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw/artifacts/public/build/target.crashreporter-symbols.zip 05:04:34 INFO - Running post-action listener: _resource_record_post_action 05:04:34 INFO - [mozharness: 2017-02-03 13:04:34.406644Z] Finished read-buildbot-config step (success) 05:04:34 INFO - [mozharness: 2017-02-03 13:04:34.406864Z] Running download-and-extract step. 05:04:34 INFO - Running pre-action listener: _resource_record_pre_action 05:04:34 INFO - Running main action method: download_and_extract 05:04:34 INFO - mkdir: /builds/slave/test/build/tests 05:04:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:34 INFO - trying https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw/artifacts/public/build/target.test_packages.json 05:04:34 INFO - Downloading https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 05:04:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 05:04:34 INFO - Downloaded 896 bytes. 05:04:34 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 05:04:34 INFO - Using the following test package requirements: 05:04:34 INFO - {u'common': [u'target.common.tests.zip'], 05:04:34 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 05:04:34 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 05:04:34 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 05:04:34 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 05:04:34 INFO - u'mozbase': [u'target.common.tests.zip'], 05:04:34 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 05:04:34 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 05:04:34 INFO - u'web-platform': [u'target.common.tests.zip', 05:04:34 INFO - u'target.web-platform.tests.zip'], 05:04:34 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 05:04:34 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 05:04:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw/artifacts/public/build/target.common.tests.zip 05:04:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:04:34 INFO - Fetch https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw/artifacts/public/build/target.common.tests.zip into memory 05:04:35 INFO - Expected file size: 39901159 05:04:35 INFO - Obtained file size: 39901159 05:04:40 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 05:04:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw/artifacts/public/build/target.common.tests.zip 05:04:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw/artifacts/public/build/target.common.tests.zip'}, attempt #1 05:04:40 INFO - Fetch https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw/artifacts/public/build/target.common.tests.zip into memory 05:04:41 INFO - Expected file size: 39901159 05:04:41 INFO - Obtained file size: 39901159 05:04:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw/artifacts/public/build/target.talos.tests.zip 05:04:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw/artifacts/public/build/target.talos.tests.zip'}, attempt #1 05:04:45 INFO - Fetch https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw/artifacts/public/build/target.talos.tests.zip into memory 05:04:46 INFO - Expected file size: 14403454 05:04:46 INFO - Obtained file size: 14403454 05:04:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:46 INFO - trying https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw/artifacts/public/build/target.tar.bz2 05:04:46 INFO - Downloading https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 05:04:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 05:04:47 INFO - Downloaded 56307146 bytes. 05:04:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw/artifacts/public/build/target.tar.bz2 05:04:47 INFO - mkdir: /builds/slave/test/properties 05:04:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:04:47 INFO - Writing to file /builds/slave/test/properties/build_url 05:04:47 INFO - Contents: 05:04:47 INFO - build_url:https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw/artifacts/public/build/target.tar.bz2 05:04:47 INFO - Running post-action listener: _resource_record_post_action 05:04:47 INFO - Running post-action listener: set_extra_try_arguments 05:04:47 INFO - [mozharness: 2017-02-03 13:04:47.844409Z] Finished download-and-extract step (success) 05:04:47 INFO - [mozharness: 2017-02-03 13:04:47.844506Z] Running populate-webroot step. 05:04:47 INFO - Running pre-action listener: _resource_record_pre_action 05:04:47 INFO - Running main action method: populate_webroot 05:04:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:04:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:04:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:04:47 INFO - '--tppagecycles', 05:04:47 INFO - '7'], 05:04:47 INFO - 'tests': ['tsvgm']}}, 05:04:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:04:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:04:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:04:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:04:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:04:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:04:47 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:04:47 INFO - 'talos_options': ['--disable-e10s'], 05:04:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:04:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:04:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:04:47 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:04:47 INFO - 'talos_options': ['--disable-e10s'], 05:04:47 INFO - 'tests': ['damp', 'tps']}, 05:04:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:04:47 INFO - 'tests': ['damp', 'tps']}, 05:04:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:04:47 INFO - 'tests': ['dromaeo_dom']}, 05:04:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:04:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:04:47 INFO - 'tests': ['basic_compositor_video']}, 05:04:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:04:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:04:47 INFO - 'tests': ['a11yr', 05:04:47 INFO - 'ts_paint', 05:04:47 INFO - 'tpaint', 05:04:47 INFO - 'sessionrestore', 05:04:47 INFO - 'sessionrestore_no_auto_restore', 05:04:47 INFO - 'tabpaint']}, 05:04:47 INFO - 'other-e10s': {'tests': ['a11yr', 05:04:47 INFO - 'ts_paint', 05:04:47 INFO - 'tpaint', 05:04:47 INFO - 'sessionrestore', 05:04:47 INFO - 'sessionrestore_no_auto_restore', 05:04:47 INFO - 'tabpaint']}, 05:04:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:04:47 INFO - 'ts_paint', 05:04:47 INFO - 'tpaint', 05:04:47 INFO - 'sessionrestore', 05:04:47 INFO - 'sessionrestore_no_auto_restore', 05:04:47 INFO - 'tabpaint']}, 05:04:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:04:47 INFO - 'ts_paint', 05:04:47 INFO - 'tpaint', 05:04:47 INFO - 'sessionrestore', 05:04:47 INFO - 'sessionrestore_no_auto_restore', 05:04:47 INFO - 'tabpaint']}, 05:04:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:04:47 INFO - 'tests': ['a11yr', 05:04:47 INFO - 'ts_paint', 05:04:47 INFO - 'tpaint', 05:04:47 INFO - 'sessionrestore', 05:04:47 INFO - 'sessionrestore_no_auto_restore', 05:04:47 INFO - 'tabpaint']}, 05:04:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:04:47 INFO - 'tests': ['a11yr', 05:04:47 INFO - 'ts_paint', 05:04:47 INFO - 'tpaint', 05:04:47 INFO - 'sessionrestore', 05:04:47 INFO - 'sessionrestore_no_auto_restore', 05:04:47 INFO - 'tabpaint']}, 05:04:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:04:47 INFO - 'tests': ['tsvgx', 05:04:47 INFO - 'tsvgr_opacity', 05:04:47 INFO - 'tart', 05:04:47 INFO - 'tscrollx', 05:04:47 INFO - 'cart', 05:04:47 INFO - 'tsvg_static']}, 05:04:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:04:47 INFO - 'tsvgr_opacity', 05:04:47 INFO - 'tart', 05:04:47 INFO - 'tscrollx', 05:04:47 INFO - 'cart', 05:04:47 INFO - 'tsvg_static']}, 05:04:47 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:04:47 INFO - 'talos_options': ['--disable-e10s'], 05:04:47 INFO - 'tests': ['tp5o']}, 05:04:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:04:47 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:04:47 INFO - 'talos_options': ['--disable-e10s', 05:04:47 INFO - '--xperf_path', 05:04:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:04:47 INFO - 'tests': ['tp5n']}, 05:04:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:04:47 INFO - 'talos_options': ['--xperf_path', 05:04:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:04:47 INFO - 'tests': ['tp5n']}}, 05:04:47 INFO - 'talos.zip': {'path': '', 05:04:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:04:47 INFO - Running post-action listener: _resource_record_post_action 05:04:47 INFO - [mozharness: 2017-02-03 13:04:47.857675Z] Finished populate-webroot step (success) 05:04:47 INFO - [mozharness: 2017-02-03 13:04:47.857765Z] Running create-virtualenv step. 05:04:47 INFO - Running pre-action listener: _resource_record_pre_action 05:04:47 INFO - Running main action method: create_virtualenv 05:04:47 INFO - Creating virtualenv /builds/slave/test/build/venv 05:04:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:04:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:04:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:04:47 INFO - Using real prefix '/usr' 05:04:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:04:48 INFO - Installing distribute.............................................................................................................................................................................................done. 05:04:50 INFO - Installing pip.................done. 05:04:50 INFO - Return code: 0 05:04:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:04:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:04:50 INFO - Reading from file tmpfile_stdout 05:04:50 INFO - Output received: 05:04:50 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:04:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2773480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2770820>, '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 0x2771520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27719b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:04:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:04:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:04:50 INFO - Using env: {'DISPLAY': ':0', 05:04:50 INFO - 'HOME': '/home/cltbld', 05:04:50 INFO - 'LANG': 'en_US.UTF-8', 05:04:50 INFO - 'LANGUAGE': 'en_US:en', 05:04:50 INFO - 'LOGNAME': 'cltbld', 05:04:50 INFO - 'MAIL': '/var/mail/cltbld', 05:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:50 INFO - 'MOZ_NO_REMOTE': '1', 05:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:50 INFO - 'NO_EM_RESTART': '1', 05:04:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:50 INFO - 'PWD': '/builds/slave/test', 05:04:50 INFO - 'SHELL': '/bin/bash', 05:04:50 INFO - 'SHLVL': '1', 05:04:50 INFO - 'TERM': 'linux', 05:04:50 INFO - 'TMOUT': '86400', 05:04:50 INFO - 'USER': 'cltbld', 05:04:50 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095', 05:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:50 INFO - '_': '/tools/buildbot/bin/python'} 05:04:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:50 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:04:50 INFO - Cleaning up... 05:04:50 INFO - Return code: 0 05:04:50 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2773480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2770820>, '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 0x2771520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27719b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:04:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:04:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:04:50 INFO - Using env: {'DISPLAY': ':0', 05:04:50 INFO - 'HOME': '/home/cltbld', 05:04:50 INFO - 'LANG': 'en_US.UTF-8', 05:04:50 INFO - 'LANGUAGE': 'en_US:en', 05:04:50 INFO - 'LOGNAME': 'cltbld', 05:04:50 INFO - 'MAIL': '/var/mail/cltbld', 05:04:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:50 INFO - 'MOZ_NO_REMOTE': '1', 05:04:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:50 INFO - 'NO_EM_RESTART': '1', 05:04:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:50 INFO - 'PWD': '/builds/slave/test', 05:04:50 INFO - 'SHELL': '/bin/bash', 05:04:50 INFO - 'SHLVL': '1', 05:04:50 INFO - 'TERM': 'linux', 05:04:50 INFO - 'TMOUT': '86400', 05:04:50 INFO - 'USER': 'cltbld', 05:04:50 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095', 05:04:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:50 INFO - '_': '/tools/buildbot/bin/python'} 05:04:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:51 INFO - Downloading/unpacking psutil>=3.1.1 05:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:04:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:04:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:04:53 INFO - Installing collected packages: psutil 05:04:53 INFO - Running setup.py install for psutil 05:04:53 INFO - building 'psutil._psutil_linux' extension 05:04:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 05:04:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 05:04:53 INFO - building 'psutil._psutil_posix' extension 05:04:53 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 05:04:53 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 05:04:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:04:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:04:53 INFO - Successfully installed psutil 05:04:53 INFO - Cleaning up... 05:04:53 INFO - Return code: 0 05:04:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2773480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2770820>, '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 0x2771520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27719b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:04:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:04:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:04:53 INFO - Using env: {'DISPLAY': ':0', 05:04:53 INFO - 'HOME': '/home/cltbld', 05:04:53 INFO - 'LANG': 'en_US.UTF-8', 05:04:53 INFO - 'LANGUAGE': 'en_US:en', 05:04:53 INFO - 'LOGNAME': 'cltbld', 05:04:53 INFO - 'MAIL': '/var/mail/cltbld', 05:04:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:53 INFO - 'MOZ_NO_REMOTE': '1', 05:04:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:53 INFO - 'NO_EM_RESTART': '1', 05:04:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:53 INFO - 'PWD': '/builds/slave/test', 05:04:53 INFO - 'SHELL': '/bin/bash', 05:04:53 INFO - 'SHLVL': '1', 05:04:53 INFO - 'TERM': 'linux', 05:04:53 INFO - 'TMOUT': '86400', 05:04:53 INFO - 'USER': 'cltbld', 05:04:53 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095', 05:04:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:53 INFO - '_': '/tools/buildbot/bin/python'} 05:04:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:04:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:04:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:04:56 INFO - Installing collected packages: mozsystemmonitor 05:04:56 INFO - Running setup.py install for mozsystemmonitor 05:04:56 INFO - Successfully installed mozsystemmonitor 05:04:56 INFO - Cleaning up... 05:04:56 INFO - Return code: 0 05:04:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:04: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')]} 05:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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')]} 05:04:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2773480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2770820>, '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 0x2771520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27719b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:04: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==2.5.1'] in /builds/slave/test/build 05:04: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==2.5.1 05:04:56 INFO - Using env: {'DISPLAY': ':0', 05:04:56 INFO - 'HOME': '/home/cltbld', 05:04:56 INFO - 'LANG': 'en_US.UTF-8', 05:04:56 INFO - 'LANGUAGE': 'en_US:en', 05:04:56 INFO - 'LOGNAME': 'cltbld', 05:04:56 INFO - 'MAIL': '/var/mail/cltbld', 05:04:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:56 INFO - 'MOZ_NO_REMOTE': '1', 05:04:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:56 INFO - 'NO_EM_RESTART': '1', 05:04:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:56 INFO - 'PWD': '/builds/slave/test', 05:04:56 INFO - 'SHELL': '/bin/bash', 05:04:56 INFO - 'SHLVL': '1', 05:04:56 INFO - 'TERM': 'linux', 05:04:56 INFO - 'TMOUT': '86400', 05:04:56 INFO - 'USER': 'cltbld', 05:04:56 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095', 05:04:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:56 INFO - '_': '/tools/buildbot/bin/python'} 05:04:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:56 INFO - Downloading/unpacking jsonschema==2.5.1 05:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:04:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:58 INFO - Downloading functools32-3.2.3-2.tar.gz 05:04:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:04:58 INFO - warning: no files found matching '*.txt' 05:04:58 INFO - no previously-included directories found matching 'build' 05:04:58 INFO - no previously-included directories found matching 'dist' 05:04:58 INFO - no previously-included directories found matching '.git*' 05:04:58 INFO - Installing collected packages: jsonschema, functools32 05:04:58 INFO - Running setup.py install for functools32 05:04:58 INFO - warning: no files found matching '*.txt' 05:04:58 INFO - no previously-included directories found matching 'build' 05:04:58 INFO - no previously-included directories found matching 'dist' 05:04:58 INFO - no previously-included directories found matching '.git*' 05:04:58 INFO - Successfully installed jsonschema functools32 05:04:58 INFO - Cleaning up... 05:04:58 INFO - Return code: 0 05:04:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2773480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2770820>, '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 0x2771520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27719b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:04:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:04:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:04:58 INFO - Using env: {'DISPLAY': ':0', 05:04:58 INFO - 'HOME': '/home/cltbld', 05:04:58 INFO - 'LANG': 'en_US.UTF-8', 05:04:58 INFO - 'LANGUAGE': 'en_US:en', 05:04:58 INFO - 'LOGNAME': 'cltbld', 05:04:58 INFO - 'MAIL': '/var/mail/cltbld', 05:04:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:58 INFO - 'MOZ_NO_REMOTE': '1', 05:04:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:58 INFO - 'NO_EM_RESTART': '1', 05:04:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:58 INFO - 'PWD': '/builds/slave/test', 05:04:58 INFO - 'SHELL': '/bin/bash', 05:04:58 INFO - 'SHLVL': '1', 05:04:58 INFO - 'TERM': 'linux', 05:04:58 INFO - 'TMOUT': '86400', 05:04:58 INFO - 'USER': 'cltbld', 05:04:58 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095', 05:04:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:58 INFO - '_': '/tools/buildbot/bin/python'} 05:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:59 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:04:59 INFO - Cleaning up... 05:04:59 INFO - Return code: 0 05:04:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:04:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:04:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:04:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:04:59 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 0x24011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2773480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2770820>, '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 0x2771520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27719b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:04:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:04:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:04:59 INFO - Using env: {'DISPLAY': ':0', 05:04:59 INFO - 'HOME': '/home/cltbld', 05:04:59 INFO - 'LANG': 'en_US.UTF-8', 05:04:59 INFO - 'LANGUAGE': 'en_US:en', 05:04:59 INFO - 'LOGNAME': 'cltbld', 05:04:59 INFO - 'MAIL': '/var/mail/cltbld', 05:04:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:04:59 INFO - 'MOZ_NO_REMOTE': '1', 05:04:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:04:59 INFO - 'NO_EM_RESTART': '1', 05:04:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:04:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:04:59 INFO - 'PWD': '/builds/slave/test', 05:04:59 INFO - 'SHELL': '/bin/bash', 05:04:59 INFO - 'SHLVL': '1', 05:04:59 INFO - 'TERM': 'linux', 05:04:59 INFO - 'TMOUT': '86400', 05:04:59 INFO - 'USER': 'cltbld', 05:04:59 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095', 05:04:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:04:59 INFO - '_': '/tools/buildbot/bin/python'} 05:04:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:04:59 INFO - Downloading/unpacking blobuploader==1.2.4 05:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:04:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:04:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:04:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:01 INFO - Downloading blobuploader-1.2.4.tar.gz 05:05:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:05:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:05:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:02 INFO - Downloading docopt-0.6.1.tar.gz 05:05:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:05:02 INFO - Installing collected packages: blobuploader, requests, docopt 05:05:02 INFO - Running setup.py install for blobuploader 05:05:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:05:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:05:02 INFO - Running setup.py install for requests 05:05:02 INFO - Running setup.py install for docopt 05:05:02 INFO - Successfully installed blobuploader requests docopt 05:05:02 INFO - Cleaning up... 05:05:02 INFO - Return code: 0 05:05:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:02 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 0x24011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2773480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2770820>, '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 0x2771520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27719b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:05:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:05:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:05:02 INFO - Using env: {'DISPLAY': ':0', 05:05:02 INFO - 'HOME': '/home/cltbld', 05:05:02 INFO - 'LANG': 'en_US.UTF-8', 05:05:02 INFO - 'LANGUAGE': 'en_US:en', 05:05:02 INFO - 'LOGNAME': 'cltbld', 05:05:02 INFO - 'MAIL': '/var/mail/cltbld', 05:05:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:02 INFO - 'MOZ_NO_REMOTE': '1', 05:05:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:02 INFO - 'NO_EM_RESTART': '1', 05:05:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:02 INFO - 'PWD': '/builds/slave/test', 05:05:02 INFO - 'SHELL': '/bin/bash', 05:05:02 INFO - 'SHLVL': '1', 05:05:02 INFO - 'TERM': 'linux', 05:05:02 INFO - 'TMOUT': '86400', 05:05:02 INFO - 'USER': 'cltbld', 05:05:02 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095', 05:05:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:02 INFO - '_': '/tools/buildbot/bin/python'} 05:05:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:05:03 INFO - Running setup.py (path:/tmp/pip-qxQJOV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:05:03 INFO - Running setup.py (path:/tmp/pip-4v3aId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:05:03 INFO - Running setup.py (path:/tmp/pip-t9T9Gd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:05:03 INFO - Running setup.py (path:/tmp/pip-5gqAg0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:05:03 INFO - Running setup.py (path:/tmp/pip-GVUqy3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:05:03 INFO - Running setup.py (path:/tmp/pip-yz1KUw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:05:03 INFO - Running setup.py (path:/tmp/pip-MtAtDc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:05:03 INFO - Running setup.py (path:/tmp/pip-PFP4T2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:05:03 INFO - Running setup.py (path:/tmp/pip-DrCFBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:05:03 INFO - Running setup.py (path:/tmp/pip-nbIg2Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:05:03 INFO - Running setup.py (path:/tmp/pip-OWHkur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:05:03 INFO - Running setup.py (path:/tmp/pip-9bMaNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:05:03 INFO - Running setup.py (path:/tmp/pip-jCMBz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:05:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:05:03 INFO - Running setup.py (path:/tmp/pip-fxmAV_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:04 INFO - Running setup.py (path:/tmp/pip-jAAAU7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:05:04 INFO - Running setup.py (path:/tmp/pip-C2o9SV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:05:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:05:04 INFO - Running setup.py (path:/tmp/pip-7NkfMx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:05:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:05:04 INFO - Running setup.py install for manifestparser 05:05:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:05:04 INFO - Running setup.py install for mozcrash 05:05:04 INFO - Running setup.py install for mozdebug 05:05:04 INFO - Running setup.py install for mozdevice 05:05:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:05:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:05:04 INFO - Running setup.py install for mozfile 05:05:04 INFO - Running setup.py install for mozhttpd 05:05:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:05:04 INFO - Running setup.py install for mozinfo 05:05:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:05:04 INFO - Running setup.py install for mozInstall 05:05:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:05:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:05:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:05:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:05:05 INFO - Running setup.py install for mozleak 05:05:05 INFO - Running setup.py install for mozlog 05:05:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:05:05 INFO - Running setup.py install for moznetwork 05:05:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:05:05 INFO - Running setup.py install for mozprocess 05:05:05 INFO - Running setup.py install for mozprofile 05:05:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:05:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:05:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:05:05 INFO - Running setup.py install for mozrunner 05:05:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:05:05 INFO - Running setup.py install for mozscreenshot 05:05:05 INFO - Running setup.py install for moztest 05:05:05 INFO - Running setup.py install for mozversion 05:05:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:05:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:05:06 INFO - Cleaning up... 05:05:06 INFO - Return code: 0 05:05:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:06 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 0x24011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2773480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2770820>, '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 0x2771520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27719b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:05:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:05:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:05:06 INFO - Using env: {'DISPLAY': ':0', 05:05:06 INFO - 'HOME': '/home/cltbld', 05:05:06 INFO - 'LANG': 'en_US.UTF-8', 05:05:06 INFO - 'LANGUAGE': 'en_US:en', 05:05:06 INFO - 'LOGNAME': 'cltbld', 05:05:06 INFO - 'MAIL': '/var/mail/cltbld', 05:05:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:06 INFO - 'MOZ_NO_REMOTE': '1', 05:05:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:06 INFO - 'NO_EM_RESTART': '1', 05:05:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:06 INFO - 'PWD': '/builds/slave/test', 05:05:06 INFO - 'SHELL': '/bin/bash', 05:05:06 INFO - 'SHLVL': '1', 05:05:06 INFO - 'TERM': 'linux', 05:05:06 INFO - 'TMOUT': '86400', 05:05:06 INFO - 'USER': 'cltbld', 05:05:06 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095', 05:05:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:06 INFO - '_': '/tools/buildbot/bin/python'} 05:05:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:05:06 INFO - Running setup.py (path:/tmp/pip-fSEbVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:05:06 INFO - Running setup.py (path:/tmp/pip-oHcRBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:05:06 INFO - Running setup.py (path:/tmp/pip-gm1fBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:05:06 INFO - Running setup.py (path:/tmp/pip-eDc2rW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:05:06 INFO - Running setup.py (path:/tmp/pip-m1Cbhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:05:06 INFO - Running setup.py (path:/tmp/pip-OZFtIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:05:06 INFO - Running setup.py (path:/tmp/pip-AAqhin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:05:06 INFO - Running setup.py (path:/tmp/pip-17eU9B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:05:06 INFO - Running setup.py (path:/tmp/pip-cNzX6l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:05:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:05:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:05:06 INFO - Running setup.py (path:/tmp/pip-lmwy1D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:05:07 INFO - Running setup.py (path:/tmp/pip-1iGSh6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:05:07 INFO - Running setup.py (path:/tmp/pip-SyaTkC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:05:07 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)) 05:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:05:07 INFO - Running setup.py (path:/tmp/pip-bNwV0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:05:07 INFO - Running setup.py (path:/tmp/pip-eh8qEn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:07 INFO - Running setup.py (path:/tmp/pip-W6Y3CY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:05:07 INFO - Running setup.py (path:/tmp/pip-fHyZvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:05:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:05:07 INFO - Running setup.py (path:/tmp/pip-cf0js3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:05:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:05:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:05:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:05:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:05:09 INFO - Downloading blessings-1.6.tar.gz 05:05:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:05:09 INFO - Installing collected packages: blessings 05:05:09 INFO - Running setup.py install for blessings 05:05:09 INFO - Successfully installed blessings 05:05:09 INFO - Cleaning up... 05:05:09 INFO - Return code: 0 05:05:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:05:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:05:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:05:10 INFO - Reading from file tmpfile_stdout 05:05:10 INFO - Current package versions: 05:05:10 INFO - argparse == 1.2.1 05:05:10 INFO - blessings == 1.6 05:05:10 INFO - blobuploader == 1.2.4 05:05:10 INFO - docopt == 0.6.1 05:05:10 INFO - functools32 == 3.2.3-2 05:05:10 INFO - jsonschema == 2.5.1 05:05:10 INFO - manifestparser == 1.1 05:05:10 INFO - mozInstall == 1.12 05:05:10 INFO - mozcrash == 1.0 05:05:10 INFO - mozdebug == 0.1 05:05:10 INFO - mozdevice == 0.49 05:05:10 INFO - mozfile == 1.2 05:05:10 INFO - mozhttpd == 0.7 05:05:10 INFO - mozinfo == 0.9 05:05:10 INFO - mozleak == 0.1 05:05:10 INFO - mozlog == 3.4 05:05:10 INFO - moznetwork == 0.27 05:05:10 INFO - mozprocess == 0.24 05:05:10 INFO - mozprofile == 0.28 05:05:10 INFO - mozrunner == 6.13 05:05:10 INFO - mozscreenshot == 0.1 05:05:10 INFO - mozsystemmonitor == 0.3 05:05:10 INFO - moztest == 0.8 05:05:10 INFO - mozversion == 1.4 05:05:10 INFO - psutil == 3.1.1 05:05:10 INFO - requests == 1.2.3 05:05:10 INFO - wsgiref == 0.1.2 05:05:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:10 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 0x24011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2773480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2770820>, '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 0x2771520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27719b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:05:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:05:10 INFO - Using env: {'DISPLAY': ':0', 05:05:10 INFO - 'HOME': '/home/cltbld', 05:05:10 INFO - 'LANG': 'en_US.UTF-8', 05:05:10 INFO - 'LANGUAGE': 'en_US:en', 05:05:10 INFO - 'LOGNAME': 'cltbld', 05:05:10 INFO - 'MAIL': '/var/mail/cltbld', 05:05:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:10 INFO - 'MOZ_NO_REMOTE': '1', 05:05:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:10 INFO - 'NO_EM_RESTART': '1', 05:05:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:10 INFO - 'PWD': '/builds/slave/test', 05:05:10 INFO - 'SHELL': '/bin/bash', 05:05:10 INFO - 'SHLVL': '1', 05:05:10 INFO - 'TERM': 'linux', 05:05:10 INFO - 'TMOUT': '86400', 05:05:10 INFO - 'USER': 'cltbld', 05:05:10 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095', 05:05:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:10 INFO - '_': '/tools/buildbot/bin/python'} 05:05:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:05:10 INFO - Cleaning up... 05:05:10 INFO - Return code: 0 05:05:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:05:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:05:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:05:10 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 0x24011f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2512a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2773480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2770820>, '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 0x2771520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27719b0>, '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': '97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 05:05:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:05:10 INFO - Using env: {'DISPLAY': ':0', 05:05:10 INFO - 'HOME': '/home/cltbld', 05:05:10 INFO - 'LANG': 'en_US.UTF-8', 05:05:10 INFO - 'LANGUAGE': 'en_US:en', 05:05:10 INFO - 'LOGNAME': 'cltbld', 05:05:10 INFO - 'MAIL': '/var/mail/cltbld', 05:05:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:10 INFO - 'MOZ_NO_REMOTE': '1', 05:05:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:10 INFO - 'NO_EM_RESTART': '1', 05:05:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:10 INFO - 'PWD': '/builds/slave/test', 05:05:10 INFO - 'SHELL': '/bin/bash', 05:05:10 INFO - 'SHLVL': '1', 05:05:10 INFO - 'TERM': 'linux', 05:05:10 INFO - 'TMOUT': '86400', 05:05:10 INFO - 'USER': 'cltbld', 05:05:10 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095', 05:05:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:10 INFO - '_': '/tools/buildbot/bin/python'} 05:05:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:05:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:05:10 INFO - Cleaning up... 05:05:10 INFO - Return code: 0 05:05:10 INFO - Running post-action listener: _resource_record_post_action 05:05:10 INFO - Running post-action listener: _start_resource_monitoring 05:05:10 INFO - Starting resource monitoring. 05:05:10 INFO - [mozharness: 2017-02-03 13:05:10.512959Z] Finished create-virtualenv step (success) 05:05:10 INFO - [mozharness: 2017-02-03 13:05:10.513413Z] Running install step. 05:05:10 INFO - Running pre-action listener: _resource_record_pre_action 05:05:10 INFO - Running main action method: install 05:05:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:05:10 INFO - Reading from file tmpfile_stdout 05:05:10 INFO - Detecting whether we're running mozinstall >=1.0... 05:05:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:05:10 INFO - Reading from file tmpfile_stdout 05:05:10 INFO - Output received: 05:05:10 INFO - Usage: mozinstall [options] installer 05:05:10 INFO - Options: 05:05:10 INFO - -h, --help show this help message and exit 05:05:10 INFO - -d DEST, --destination=DEST 05:05:10 INFO - Directory to install application into. [default: 05:05:10 INFO - "/builds/slave/test"] 05:05:10 INFO - --app=APP Application being installed. [default: firefox] 05:05:10 INFO - mkdir: /builds/slave/test/build/application 05:05:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 05:05:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 05:05:27 INFO - Reading from file tmpfile_stdout 05:05:27 INFO - Output received: 05:05:27 INFO - /builds/slave/test/build/application/firefox/firefox 05:05:27 INFO - Running post-action listener: _resource_record_post_action 05:05:27 INFO - [mozharness: 2017-02-03 13:05:27.045094Z] Finished install step (success) 05:05:27 INFO - [mozharness: 2017-02-03 13:05:27.045369Z] Running run-tests step. 05:05:27 INFO - Running pre-action listener: _resource_record_pre_action 05:05:27 INFO - Running main action method: run_tests 05:05:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:05:27 INFO - Python 2.7.3 05:05:27 INFO - Return code: 0 05:05:27 INFO - grabbing minidump binary from tooltool 05:05:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:05:27 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 0x2770820>, '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 0x2771520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27719b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:05:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:05:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 05:05:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:05:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:05:27 INFO - Return code: 0 05:05:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:05:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:05:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:05:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:05:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:05:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 05:05:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-068 --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 05:05:27 INFO - Using env: {'DISPLAY': ':0', 05:05:27 INFO - 'HOME': '/home/cltbld', 05:05:27 INFO - 'LANG': 'en_US.UTF-8', 05:05:27 INFO - 'LANGUAGE': 'en_US:en', 05:05:27 INFO - 'LOGNAME': 'cltbld', 05:05:27 INFO - 'MAIL': '/var/mail/cltbld', 05:05:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:05:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:05:27 INFO - 'MOZ_NO_REMOTE': '1', 05:05:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:05:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:05:27 INFO - 'NO_EM_RESTART': '1', 05:05:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:05:27 INFO - 'PWD': '/builds/slave/test', 05:05:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:05:27 INFO - 'SHELL': '/bin/bash', 05:05:27 INFO - 'SHLVL': '1', 05:05:27 INFO - 'TERM': 'linux', 05:05:27 INFO - 'TMOUT': '86400', 05:05:27 INFO - 'USER': 'cltbld', 05:05:27 INFO - 'XDG_SESSION_COOKIE': '97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095', 05:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:05:27 INFO - '_': '/tools/buildbot/bin/python'} 05:05:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-068', '--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 05:05:27 INFO - mozversion application_buildid: 20170203122547 05:05:27 INFO - mozversion application_changeset: 9f17a6fc04f9540ffe11d7ad4e22db5a37df6e23 05:05:27 INFO - mozversion application_display_name: Nightly 05:05:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:05:27 INFO - mozversion application_name: Firefox 05:05:27 INFO - mozversion application_remotingname: firefox 05:05:27 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:05:27 INFO - mozversion application_vendor: Mozilla 05:05:27 INFO - mozversion application_version: 54.0a1 05:05:27 INFO - mozversion platform_buildid: 20170203122547 05:05:27 INFO - mozversion platform_changeset: 9f17a6fc04f9540ffe11d7ad4e22db5a37df6e23 05:05:27 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:05:27 INFO - mozversion platform_version: 54.0a1 05:05:27 INFO - using testdate: 1486127127 05:05:27 INFO - actual date: 1486127127 05:05:27 INFO - starting webserver on 'localhost:55259' 05:05:27 INFO - SUITE-START | Running 2 tests 05:05:27 INFO - TEST-START | dromaeo_css 05:05:27 INFO - operating with platform_type : linux_ 05:05:27 INFO - Initialising browser for dromaeo_css test... 05:05:27 INFO - TEST-INFO | started process 29797 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxMprvo/profile http://localhost:55259/getInfo.html) 05:05:31 INFO - PROCESS | 29797 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 05:05:32 INFO - PROCESS | 29797 | __metrics Screen width/height:1600/1200 05:05:32 INFO - PROCESS | 29797 | colorDepth:24 05:05:32 INFO - PROCESS | 29797 | Browser inner width/height: 1024/697 05:05:32 INFO - PROCESS | 29797 | __metrics 05:05:32 INFO - PROCESS | 29797 | 1486127132460 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:6301:36 < canClose@browser.js:5167:12 < forceQuit@jar:file:///tmp/tmpxMprvo/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpxMprvo/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpxMprvo/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpxMprvo/profile/extensions/talos-powers@TalosPowersService.js:55:9 05:05:32 ERROR - PROCESS | 29797 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 05:05:33 INFO - TEST-INFO | 29797: exit 0 05:05:33 INFO - Browser initialized. 05:05:33 INFO - Running cycle 1/1 for dromaeo_css test... 05:05:33 INFO - TEST-INFO | started process 29917 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpxMprvo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:05:45 INFO - PROCESS | 29917 | RSS: Main: 158867456 05:05:45 INFO - PROCESS | 29917 | 05:08:49 INFO - PROCESS | 29917 | Cycle 1(1): loaded http://localhost:55259/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55259/tests/dromaeo/cssquery-ext.html) 05:08:51 INFO - PROCESS | 29917 | RSS: Main: 168984576 05:08:51 INFO - PROCESS | 29917 | 05:10:33 INFO - PROCESS | 29917 | ************************* 05:10:33 INFO - PROCESS | 29917 | A coding exception was thrown and uncaught in a Task. 05:10:33 INFO - PROCESS | 29917 | 05:10:33 ERROR - PROCESS | 29917 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:10:33 INFO - PROCESS | 29917 | Full stack: 05:10:33 INFO - PROCESS | 29917 | ************************* 05:11:54 INFO - PROCESS | 29917 | Cycle 1(1): loaded http://localhost:55259/tests/dromaeo/cssquery-ext.html (next: http://localhost:55259/tests/dromaeo/cssquery-jquery.html) 05:11:55 INFO - PROCESS | 29917 | RSS: Main: 163475456 05:11:55 INFO - PROCESS | 29917 | 05:14:57 INFO - PROCESS | 29917 | Cycle 1(1): loaded http://localhost:55259/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55259/tests/dromaeo/cssquery-mootools.html) 05:14:57 INFO - PROCESS | 29917 | RSS: Main: 170680320 05:14:57 INFO - PROCESS | 29917 | 05:17:59 INFO - PROCESS | 29917 | Cycle 1(1): loaded http://localhost:55259/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55259/tests/dromaeo/cssquery-prototype.html) 05:18:00 INFO - PROCESS | 29917 | RSS: Main: 163721216 05:18:00 INFO - PROCESS | 29917 | 05:21:03 INFO - PROCESS | 29917 | Cycle 1(1): loaded http://localhost:55259/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55259/tests/dromaeo/cssquery-yui.html) 05:21:04 INFO - PROCESS | 29917 | RSS: Main: 167518208 05:21:04 INFO - PROCESS | 29917 | 05:24:07 INFO - PROCESS | 29917 | Cycle 1(1): loaded http://localhost:55259/tests/dromaeo/cssquery-yui.html (next: http://localhost:55259/tests/dromaeo/cssquery-dojo.html) 05:24:07 INFO - PROCESS | 29917 | RSS: Main: 169500672 05:24:07 INFO - PROCESS | 29917 | 05:24:07 INFO - PROCESS | 29917 | __start_tp_report 05:24:07 INFO - PROCESS | 29917 | _x_x_mozilla_page_load 05:24:07 INFO - PROCESS | 29917 | _x_x_mozilla_page_load_details 05:24:07 INFO - PROCESS | 29917 | |i|pagename|runs| 05:24:07 INFO - PROCESS | 29917 | |0;dojo.html;2579.9355016124605;2581.5998520229364;2583.48330333933;2608.7391260873915;2620.54140525408;4696.201645720227;4738.90522189556;4756.120117778213;4774.355462012627;4817.22924332107;4700.882477938053;4733.8816529586775;4787.257975013869;4883.731394773286;4967.056259310738;4270.530241673429;4368.432103826506;4422.469303683562;4582.885427864313;4583.03756211196;4487.977560112195;4502;4503.189425903336;4527.683062185648;4528.18492671319;4338.934915976263;4349.69552131351;4380.3210502372185;4406.867793966187;4427.1367083418745;4410.6030457259;4412.536683648235;4440.845380201139;4448.043670610802;4463.575960283768;4321.567843215685;4382.671299652538;4383.495897971742;4392.407025051641;4430.069685366077;4655.627549796008;4688.29675548667;4726.480087190406;4748.95251047492;4784.330193772875;5061.013102445025;5062.31658726071;5065.848024559269;5089.160288552422;5122.487751224885;5103.23451482277;5119.0529751996;5119.897602047976;5127.230915362688;5158;4642.628589712815;4695.976520117378;4792.544708252711;4798.064377446364;4852.927206091911;5263.842084737464;5309.3894202166475;5328.573714102862;5335.439778823245;5339.946600533945;5058.367704036996;5065.7720402581235;5092.337996060489;5116.9744151279;5143.305653736773;5123.6157288202785;5162.819301324435;5168.095583272912;5178.0679477694375;5217.34783152106;5000.524950129805;5085.211792172219;5115.8721031973755;5116.386033675983;5151.5878729701535;5028.371453568304;5071.974640126776;5085.364329458817;5126.077306084941;5166.8966620668125;4268.061026574149;4274.572542745701;4303.483581970121;4325.632321252666;4353.847615333448;3702.555693316819;3753.11801726594;3768.4158955361963;3785.280796648628;3799.2021675448464;4258.510271318838;4288.571142885687;4352.042550638855;4357.324614684729;4377.343398490252;5171.81898633546;5206.088934436459;5215.348081489814;5253.1857562077175;5261;4356.128774245164;4380.8904777380185;4398.362237475612;4403.3174857897075;4458.6878918475395;4406.9559304407185;4652.813887444464;4657.4876763555985;4658.767061646904;4685.0629874025335;4734.573888350065;4843.612510999041;4877.5366340197625;4886.682365646222;4913;5037.319961805109;5043.193089105725;5049.34358533403;5052.69683818972;5113.53978141969;4780.665353425227;4793.688410253322;4798.064377446364;4799.496052914394;4867.342908707279;4948.430930442901;5030.496950304941;5050.3182070420025;5054.620903432184;5059.494050594911;4963.875903102451;4985.077760614298;5022.397312322545;5025.572826309804;5030.119729047329;4764.166270902648;4783.354247176726;4788.760561971957;4798.184308667465;4808.447028591617;4810.062037902575;4843.685160464699;4849.2726091086615;4863.4650188479945;4873;4805.37530121082;4913.41039075299;4916.041371932439;4953.603711703127;4958.925616115689;4936.506349365035;4968.850934471971;4991.825286114969;4997.675151115166;5007.7746501408255;4810.735409552508;4828.517148285284;4837.7097374157665;4881.389826271716;4930.6055515557955 05:24:07 INFO - PROCESS | 29917 | |1;ext.html;542.2923085373587;542.5090293284579;561.5479538971126;568.0967262053334;570.7716913234706;41012.43800991842;42961.35557966633;43059.35410968838;43059.78470107649;43101.56898431015;38949.221015579744;40186.39720404196;40225.7988710056;40296;40367;7615.885761713579;7733.961330193341;7760.379169666413;9018.503982280972;9269.304802139834;9211.861822072675;9212.723618291462;9262;9281.071892810698;9312.860307095365;9249.35254532183;9279.0720927907;9320.161185493303;9326.207272381822;9340.626374945028;9243.352965292432;9270.768230794216;9308;9328;9344.719658410258;9190.080991900822;9199.448033117967;9258.166764991183;9308.743319651896;9330.206932410752;32803.50794738081;32947.176320591934;32971.6702832971;33113.66886331154;33117.17855517945;3263.8368081596063;3350.329934013207;3370.0900756795772;3404.0468668772783;3404.9489257661153;25027.37431564207;25209.62185567218;25260;26199.34501637455;26463;2824.1962766514803;2944.6319210098736;3005.8196508209576;3010.1872494426602;3087.799293045945;249373;250332;252176;252281;252659;39524.209515809525;40472.79763601163;45800;46312.5368746315;46675.76662116668;45167.774161129644;48921;49131.754341228065;49339.25991110136;49409.752951235016;13270.535531256359;13362.465501380031;13431.597052088258;13437.865621343857;13439;10095;10157.695269141937;10162.796744065225;10168.237382196365;10181.54183061764;15479.613009674624;15587.844121558866;15625.761228903175;15632.609184770472;15731.292091855894;6313.337099604567;6562.2453417856605;6619.669016549154;6623.635700036448;6682.766103186463;746.8879668049836;749.1197842534999;752.6236881559221;770.4683768199924;776.1811289090065;25888.223353299432;26673.33316667099;27108.59337109945;27185.45629087407;27352.863235683693;899.8605216191501;914.6021480655936;915.8763566918514;920.0477505781485;949.2263804999042;13966.650833729034;14158.787618185735;14351.78472322916;14544.63638409027;14647.414103435956;353532;357026;358717;359255;359646;49610.255846162334;50013.74993125011;50151.498485015414;50243;50258;1201.201201201209;1201.2277037429178;1226.8282440458343;1237.888590026884;1238.9504419823286;25043.373915652253;25647.358816029748;26634;26781;26908.461830762884;41652.375214371204;41935.16129677328;42044.36933446062;42078.789606051774;42223;296106;296784;297372;298402;299293;23893.880530597235;24975.75024249807;24998.875005624854;25008.249752507454;25120.59907119905;39167;39261.214775704895;40327.59672403238;40641.1871762569;41072.38391424191;34126.65873341235;34257;34514.309713806084;34991.30017399689;35083.64916350906;34093;34309.48535771915;34428.65571344355;34715.65284347225;34716.826415867756;33414;33617.83191084029;33667.97992120481;33830;34079;28545.28636784097;31077;31090.22274443157;31169.376612468077;31208.843955780078;23302.88348558314;23390.64914026325;23642.881785590962;23737.9317930697;23832.523349533258 05:24:07 INFO - PROCESS | 29917 | |2;jquery.html;374.9737518373715;384.7821110412982;390.3598099117446;392.89784655989445;412.8885200995731;16511.587210319747;17378;18042.819571804295;18091.72862407065;18804.62390752184;17492.912535437306;17637.089880169755;17760;17991.280348786066;18096.909515452404;5030.471800460963;5079.288899554047;5246.816361427351;5252.65857719247;5263.315768950031;5078.263651770491;5164.147915593922;5174.120399532088;5198.142306519419;5222.00781851447;4947.752612369385;5140.768665410065;5153.1754919212935;5173.844784656466;5188.429272779991;4948.480409556999;5101.107306221415;5122.795088196468;5129.025485157808;5140.665856719302;4604.450704504769;4616.746078965655;4635.976820115911;4637.466691330473;4643.698159619614;21359.57280854374;21394.251201207884;21660.35018949434;21675.024623891964;21758.238461653924;2097.528056187361;2141.757313862809;2157.6224160771803;2159.276642324823;2164.632012557869;13617.455301787917;13700.177989320673;13743.450261989508;13761.931190344085;14280.428782848778;1742.9041402722846;1764.2061072517417;1846.4645252876649;1847.6581832361055;1864.459306801026;67178.66410667915;76047.23952760457;77075.22924770736;77285;78741.8817776837;10126.189904807597;10161;10767.89232107669;11025.779484410266;11143.164262680331;15252.542423727306;15253.6186595336;15288.235588220545;15294.923525382303;15314.243436181372;6891.517593768388;7059.89410158848;7062.929370706227;7236.529625574321;7329.120505539369;6499.642519661369;6600.240972288152;6753.729850805913;6759.526833121733;6775.085363475868;4242.6817988650355;4338.544452832471;4558.179527685049;4689.577937985598;4799.232122860326;1829.3863809036618;1962.5878565501405;1974.6051038859564;2017.7477815273091;2024.22067504012;927.1609193679731;935.2798345274236;952.8713623660717;975.7121649113528;988.2242439684813;16887.493375198763;17629.7355539667;17945.461636150936;17973.1013449327;18242.270309187483;946.2382781860531;953.9618415263312;954.2032402943481;957.7988622389237;968.7529679931572;9178.541072946326;9669.516524173763;9727.07592778685;9738.659146929824;9917.75205619851;444448;445971;448990;461721;482010;71972.28027719655;74878;90345.54827225822;90662.54668726613;92118.53940730254;917.6696389299847;919.5999740112939;937.8311903857372;945.2957546627806;952.066974365126;15097.698046039237;15148.16685082287;15500.92249538745;15736.60658483547;15888.205589720237;39432.21135577215;39567.80216098901;40476;40783.796081019405;40795.572154974434;51446.485535145664;51770.48229517657;53196;54832.72583637056;54857.177142343695;7324.487285889936;7460.925390746023;7677.61611919413;7774.2614451627005;8113.1886811320755;10379.377237365783;12887.484500620245;12889.613311600668;12891.548795792101;12940.676483087998;10028.849567256642;10163.390196588229;10262.43556604394;10540.57837686484;10655.573777049141;10356.430396328275;10485.423301718478;10721.463926803784;10824.512896919816;10928.78142437131;9786;10442.738931526772;10451.895481045092;10543;10926.617568385069;6255;6441.291457939529;7854;7896.68413263463;8293.95853020731;7961.482503637245;9653.03469653029;9656.855147172939;9679.386565627383;9744.951275243578 05:24:07 INFO - PROCESS | 29917 | |3;mootools.html;1332.4869925078847;1338.2773302416695;1340.792177212532;1347.6226656536162;1350.8649135086494;7236.167840698315;7347.302006309405;7599.316061554473;7708;7713;7463.440241981846;7622.542647441157;7623.428242881779;7641.808954776119;7661.310482056628;2067.524469372045;2104.547522282709;2108;2111.6938043983614;2112.661974084147;2067.55129060195;2099.5276062885882;2109.3882773995524;2117.1743020222048;2121.7984291492285;2054.189295181734;2084.0725876984748;2105.768365479796;2105.799949004842;2114.164904862578;2064.3394113883564;2066.142550841399;2076.698878662593;2081.458820706627;2082.2295750572384;1813.2475022865494;1869.6354210928873;2023.6660950943076;2040.9693854592044;2105.3157723739846;7094.219635840053;7296.270372962715;7312.1956584775635;7436.516626419266;7446.329830315298;4401.295792673189;4493.595576398107;4527.569880861313;4538.546145385468;4550;2834.291427143214;2892;2912.723291287324;2993.985030074836;2994.970050299491;970.0929630795229;982.6069572171117;994.4778991029694;1003.3127307794184;1006.4816619440994;9665.71002869915;9916.355436896578;9923.751906202402;10012.749681258027;10127;3800.56293526248;3928.4500169976227;3953.150072734376;3955.5846636102797;3972.741771784825;7609.847803043908;7670.96164519185;7758.7672369829;7759.030121234846;7785.455018148788;4380.299152135643;4443.178012067778;4444.688871778944;4448.088141930896;4468.821247150077;4005.6595189408645;4080.5103387593085;4151.73013754105;4180.310248808913;4198.412222288882;3205.7755957083245;3223.339215460825;3292.9176770580925;3321.9003429897143;3333.0500807269814;1001.7846163074973;1028.6451174344838;1038.8337865941412;1043;1046.8325067989085;806.8830019647236;817.811903262253;842.7316888083518;854.4189950833369;859.0807835615956;4627.190241707688;4780.139574876555;4789.95210047902;4791.47293797689;4827.2035114206465;485.9319695242669;496.377046806263;507.908576456234;514.1875836178829;515.3789683431456;3222.9194270143435;3226.6934641209045;3231.4506533889294;3240.8703651854134;3357.9832100839826;7807.258310460497;8096.02847658273;8412.158784121539;8789.252913502296;8800.33997450181;8822.691205807894;8942.46345219289;8944.955275223712;8954.955225223963;8956;6725.125733654593;6954.3045695431065;7011.123609548807;7020.92979070213;7021.754238601625;5150.922736159036;5184.559312458332;5207.140821764367;5311.734413279398;5348.839534813962;8359.164083591591;8396.622152003052;8426.789330266547;8499.57502124879;8501.574921254036;8193.426460147732;8304.377171712025;8378.790530236793;8433.493990360597;8442.113578074459;6097.237845269341;6138.907916381168;6240.594361366497;6242.781502647385;6248.625082495065;7108.324709152622;7128.180259270251;7172.856542869218;7196.640167991684;7198.748043818441;6442.323556026738;6519.478441724746;6536;6681.799546013627;6763.7632682855865;6437.0666253392055;6463.095166676575;6481.125048118443;6534.738610455529;6541.574797638138;5721.828345149652;5773.422657734193;5785.942140578541;5819.563532734977;5839.591228613956;4313.309870420718;4469.41897553329;4547.590716835369;4569.840055598171;4585.564371384713;4346.195953748566;4372;4478.104379124123;4501.3022981437925;4569.063342014945 05:24:07 INFO - PROCESS | 29917 | |4;prototype.html;344.1705489769655;352.3094734320731;353.189430257559;354.6435831988851;356.35677601928523;4900.754962251891;4947.554720075193;5026.447090820011;5036.269740887574;5057.974710126444;4954.331165292684;4960.776765045573;4969.676970996883;4995.950040499594;4999.4000719913665;3696.7597106188146;3839.520059992501;3861.8800547841092;3869.187470631171;3884.3396622574087;3851.2490064437447;3858.5369755629363;3867.284552357809;3872.845086196563;3890.1830615570766;3853.5761066282685;3857.2092720992127;3867.4972253606993;3869.806509674519;3875.302445559798;3642.359289515107;3812.6377994090517;3872.9806350968206;3883.320418926705;3889.883303500885;3368.0970251807894;3378.712809411203;3378.831058447068;3392.3724111039537;3401.268727223659;4806.615470762331;4811;4817.686850354716;4822.469528351879;4847.394075740533;4387.824487020515;4401.339799030139;4408.184485870092;4424.535423780489;4444.955435472693;4972.776225069881;5127.3083379966365;5188.092083885305;5201.791928322863;5207.724107593664;3672.485851980725;3680.834362453696;3695.667389934892;3707.14735610811;3713.925721485555;5234.973825130888;5429.647072940246;5441.401445840955;5471.945280547223;5472.124460086367;3731.589525152231;3737.570179429346;3743.382341913554;3756.9436458453147;3767.7927713975446;3768.3217020936495;3776.678982286536;3790.431435284674;3827.5406951166037;3827.61723827615;4377.9124417511475;4380.145871555016;4388.166248412791;4389.551448022145;4392.582704643118;5114.849158939209;5205.241222152265;5231.567321195586;5257.342832145981;5257.842264732064;1259.8614152443224;1273.6690158784093;1275.113795911851;1277.4251586785797;1285.6528737240892;839.3956351427084;885.8449771289999;889.6263569300909;896.4083704754961;900.2707806676613;4348.499922508889;4353.978230108829;4355.346697995263;4355.9981204323185;4386.298192289282;5162.496189348163;5172.793088276427;5206.323177986913;5217.373915130209;5254.632175747737;4138.441310423114;4333.1651488432335;4364.3017117261725;4380.299152135643;4402.647788176938;2762.267998980272;2777.666679998413;2782.9304267393477;2790.2047916343745;2798.720127987185;4920.926186107211;4936.580390666762;4967.230079337708;4969.807246260872;4983.27742477346;5057.443681195065;5321.920171197435;5352.464753524694;5366.382865970385;5386.5152136307925;4879.902401951941;4883;4916.139675556763;4922.4585295616735;4927.353758218964;5130.74296797287;5179.715115668674;5188.118019936695;5195.142801437721;5208.687478751287;4886.804527818847;5061.190209566452;5087.202038878676;5106.974465127651;5140.871478213075;4847.418309802846;4857.441394239708;4859.202095224789;4889.7799599018845;4996.325496057985;3736.8318425671455;3769.3026790043928;3813.504244448204;3815.9427608586448;3821.1085512670293;5268.446813084724;5303.2840566524565;5305.549028332635;5306.681599103912;5313.1764576490705;4802.423709154924;4987.977464619672;5031.3207716959205;5053.469385714594;5070.949290507047;5022.723750193774;5032.3206367139965;5040.395152581714;5051.823186188466;5057.645964782577;5124.333836601218;5129.538341549279;5142.665726727751;5149.768260428365;5158;4998.625103117353;5164.302819119521;5181.974090129525;5213.6350455467755;5241.7379131042535;5056.191009438472;5082.872928176677;5085.4406015337545;5099.79600815978;5116.181410974226 05:24:07 INFO - PROCESS | 29917 | |5;yui.html;575.6833741442211;582.8455459303283;687.4912564702121;694.2086021934991;701.3967987530724;11150.888491115087;12396.318202498858;12412.503499860006;12422.192557483757;12522.311272879988;12651.557195498159;12667.683307917307;12691.238525688465;12797.360131993386;12833.588305286434;788.5229436191108;791.707068384697;808.9676412943476;809.8056466448069;815.7552734179752;827.3711978896052;832.7043899415711;832.937529685273;834.1866679986995;836.9579873058021;857.4126723194601;858.7295002074358;859.995700021499;860.4665107633276;862.1249431826701;848.5969164646805;848.6775025490305;850.2220468271524;853.2534032721369;853.3301358433599;621.4934828115117;621.5835390288518;624.6096189881324;625.190378459891;625.809128215894;13033.543825966046;13230;13355.265460399674;13365.398557064955;13385.19688818674;12751.362431878462;13020.348982550835;13223.933880330633;13361.799573006412;13489.932550337284;9124.5437728114;9198.17216450516;9247.537623118884;9302.488363140024;9313.58088885995;3140.434721750084;3154.511050787132;3175.3966746318124;3310.9172270693184;3323.3685599736214;64306.678466607365;64372;66193.3380666192;66533.66733166351;67202.66398667975;10022.799544009078;10063.295569310225;10071.899281007243;10237.436940968319;10338.638147664795;19168.71246931297;19187;19190.13644386006;19275.132619032178;19345.90327048356;5617.606767526234;5624.91562626561;5649.322081350264;5714.114312281603;5815.040518314515;3268.264640455878;3309.2223327518013;3352.6814952579466;3378.527006219131;3404.863805447754;2920.313726274324;2961.1560705198913;2995.445842519141;3006;3017.5021121514706;477.1983068444976;478.99760501197966;482.6549017452538;490.52419153421124;492.26406522249465;567.6055141676578;594.174098003775;596.6122020686588;603.5473394953784;608.6500262349167;7819.960900195576;7910.564918929399;8010.838428427845;8474.74575762728;9140.268778497837;451.51687694166924;460.8479201863377;477.73485715428274;547.0945585056737;565.6210339072832;3824.7896365700153;3916.980415097906;4039.6970227233073;4137.855175068858;4207.26372884744;52027.219591706154;52763.472365276626;54404.183937240974;58419.123713144334;59300.11049834256;50122.49877501178;51674;52022.21966670427;52164;53015.20477192845;47491.5250847494;47952;48634.51365486371;48671.5132848667;49233.2615010768;8379.41344105931;8737.56312184401;8759.430637008574;8830.337724670548;8910.777230569029;33044.66955330416;33097.669023310424;34686.30627387387;35118;35145;38434;40644.59355406408;41253.1749365017;41638;41802.163956720084;12578.182418142791;12638.115331927045;12640.747185056063;12722.61832145037;12921.870781292067;11649.59226427071;11774.764504710029;12468.625941221779;12476.750464990468;13553.457861685421;10115.140213081677;10948.233623646587;10991.725206869893;11366.488508017324;11922.225055371373;10969.670909872717;11646.534138634359;11650.592229271935;11790.587329443428;12101.273923564615;10431.426271555138;10987.61543345979;11136;11202.38386888729;11506.654800356002;9549;9905.950470247892;10102.545385457524;10128.544215510467;10146.695599132037;8188;8820.117988201386;8939.910600893907;8993.460392376479;9674.17769489573 05:24:07 INFO - PROCESS | 29917 | __end_tp_report 05:24:07 INFO - PROCESS | 29917 | __start_cc_report 05:24:07 INFO - PROCESS | 29917 | _x_x_mozilla_cycle_collect,386 05:24:07 INFO - PROCESS | 29917 | __end_cc_report 05:24:07 INFO - PROCESS | 29917 | __startTimestamp1486128247308__endTimestamp 05:24:07 INFO - PROCESS | 29917 | 05:24:07 INFO - PROCESS | 29917 | ------- Summary: start ------- 05:24:07 INFO - PROCESS | 29917 | Number of tests: 6 05:24:07 INFO - PROCESS | 29917 | 05:24:07 INFO - PROCESS | 29917 | [#0] dojo.html Cycles:165 Average:4713.20 Median:4810.06 stddev:505.40 (10.5%) stddev-sans-first:478.44 05:24:07 INFO - PROCESS | 29917 | Values: 2579.9 2581.6 2583.5 2608.7 2620.5 4696.2 4738.9 4756.1 4774.4 4817.2 4700.9 4733.9 4787.3 4883.7 4967.1 4270.5 4368.4 4422.5 4582.9 4583.0 4488.0 4502.0 4503.2 4527.7 4528.2 4338.9 4349.7 4380.3 4406.9 4427.1 4410.6 4412.5 4440.8 4448.0 4463.6 4321.6 4382.7 4383.5 4392.4 4430.1 4655.6 4688.3 4726.5 4749.0 4784.3 5061.0 5062.3 5065.8 5089.2 5122.5 5103.2 5119.1 5119.9 5127.2 5158.0 4642.6 4696.0 4792.5 4798.1 4852.9 5263.8 5309.4 5328.6 5335.4 5339.9 5058.4 5065.8 5092.3 5117.0 5143.3 5123.6 5162.8 5168.1 5178.1 5217.3 5000.5 5085.2 5115.9 5116.4 5151.6 5028.4 5072.0 5085.4 5126.1 5166.9 4268.1 4274.6 4303.5 4325.6 4353.8 3702.6 3753.1 3768.4 3785.3 3799.2 4258.5 4288.6 4352.0 4357.3 4377.3 5171.8 5206.1 5215.3 5253.2 5261.0 4356.1 4380.9 4398.4 4403.3 4458.7 4407.0 4652.8 4657.5 4658.8 4685.1 4734.6 4843.6 4877.5 4886.7 4913.0 5037.3 5043.2 5049.3 5052.7 5113.5 4780.7 4793.7 4798.1 4799.5 4867.3 4948.4 5030.5 5050.3 5054.6 5059.5 4963.9 4985.1 5022.4 5025.6 5030.1 4764.2 4783.4 4788.8 4798.2 4808.4 4810.1 4843.7 4849.3 4863.5 4873.0 4805.4 4913.4 4916.0 4953.6 4958.9 4936.5 4968.9 4991.8 4997.7 5007.8 4810.7 4828.5 4837.7 4881.4 4930.6 05:24:07 INFO - PROCESS | 29917 | 05:24:07 INFO - PROCESS | 29917 | [#1] ext.html Cycles:180 Average:45060.81 Median:34614.98 stddev:80174.28 (231.6%) stddev-sans-first:80329.51 05:24:07 INFO - PROCESS | 29917 | Values: 542.3 542.5 561.5 568.1 570.8 41012.4 42961.4 43059.4 43059.8 43101.6 38949.2 40186.4 40225.8 40296.0 40367.0 7615.9 7734.0 7760.4 9018.5 9269.3 9211.9 9212.7 9262.0 9281.1 9312.9 9249.4 9279.1 9320.2 9326.2 9340.6 9243.4 9270.8 9308.0 9328.0 9344.7 9190.1 9199.4 9258.2 9308.7 9330.2 32803.5 32947.2 32971.7 33113.7 33117.2 3263.8 3350.3 3370.1 3404.0 3404.9 25027.4 25209.6 25260.0 26199.3 26463.0 2824.2 2944.6 3005.8 3010.2 3087.8 249373.0 250332.0 252176.0 252281.0 252659.0 39524.2 40472.8 45800.0 46312.5 46675.8 45167.8 48921.0 49131.8 49339.3 49409.8 13270.5 13362.5 13431.6 13437.9 13439.0 10095.0 10157.7 10162.8 10168.2 10181.5 15479.6 15587.8 15625.8 15632.6 15731.3 6313.3 6562.2 6619.7 6623.6 6682.8 746.9 749.1 752.6 770.5 776.2 25888.2 26673.3 27108.6 27185.5 27352.9 899.9 914.6 915.9 920.0 949.2 13966.7 14158.8 14351.8 14544.6 14647.4 353532.0 357026.0 358717.0 359255.0 359646.0 49610.3 50013.7 50151.5 50243.0 50258.0 1201.2 1201.2 1226.8 1237.9 1239.0 25043.4 25647.4 26634.0 26781.0 26908.5 41652.4 41935.2 42044.4 42078.8 42223.0 296106.0 296784.0 297372.0 298402.0 299293.0 23893.9 24975.8 24998.9 25008.2 25120.6 39167.0 39261.2 40327.6 40641.2 41072.4 34126.7 34257.0 34514.3 34991.3 35083.6 34093.0 34309.5 34428.7 34715.7 34716.8 33414.0 33617.8 33668.0 33830.0 34079.0 28545.3 31077.0 31090.2 31169.4 31208.8 23302.9 23390.6 23642.9 23737.9 23832.5 05:24:07 INFO - PROCESS | 29917 | 05:24:07 INFO - PROCESS | 29917 | [#2] jquery.html Cycles:180 Average:26941.32 Median:4610.60 stddev:75314.70 (1633.5%) stddev-sans-first:75499.56 05:24:07 INFO - PROCESS | 29917 | Values: 375.0 384.8 390.4 392.9 412.9 16511.6 17378.0 18042.8 18091.7 18804.6 17492.9 17637.1 17760.0 17991.3 18096.9 5030.5 5079.3 5246.8 5252.7 5263.3 5078.3 5164.1 5174.1 5198.1 5222.0 4947.8 5140.8 5153.2 5173.8 5188.4 4948.5 5101.1 5122.8 5129.0 5140.7 4604.5 4616.7 4636.0 4637.5 4643.7 21359.6 21394.3 21660.4 21675.0 21758.2 2097.5 2141.8 2157.6 2159.3 2164.6 13617.5 13700.2 13743.5 13761.9 14280.4 1742.9 1764.2 1846.5 1847.7 1864.5 67178.7 76047.2 77075.2 77285.0 78741.9 10126.2 10161.0 10767.9 11025.8 11143.2 15252.5 15253.6 15288.2 15294.9 15314.2 6891.5 7059.9 7062.9 7236.5 7329.1 6499.6 6600.2 6753.7 6759.5 6775.1 4242.7 4338.5 4558.2 4689.6 4799.2 1829.4 1962.6 1974.6 2017.7 2024.2 927.2 935.3 952.9 975.7 988.2 16887.5 17629.7 17945.5 17973.1 18242.3 946.2 954.0 954.2 957.8 968.8 9178.5 9669.5 9727.1 9738.7 9917.8 444448.0 445971.0 448990.0 461721.0 482010.0 71972.3 74878.0 90345.5 90662.5 92118.5 917.7 919.6 937.8 945.3 952.1 15097.7 15148.2 15500.9 15736.6 15888.2 39432.2 39567.8 40476.0 40783.8 40795.6 51446.5 51770.5 53196.0 54832.7 54857.2 7324.5 7460.9 7677.6 7774.3 8113.2 10379.4 12887.5 12889.6 12891.5 12940.7 10028.8 10163.4 10262.4 10540.6 10655.6 10356.4 10485.4 10721.5 10824.5 10928.8 9786.0 10442.7 10451.9 10543.0 10926.6 6255.0 6441.3 7854.0 7896.7 8294.0 7961.5 9653.0 9656.9 9679.4 9745.0 05:24:07 INFO - PROCESS | 29917 | 05:24:07 INFO - PROCESS | 29917 | [#3] mootools.html Cycles:180 Average:4827.53 Median:502.14 stddev:2662.53 (530.2%) stddev-sans-first:2657.05 05:24:07 INFO - PROCESS | 29917 | Values: 1332.5 1338.3 1340.8 1347.6 1350.9 7236.2 7347.3 7599.3 7708.0 7713.0 7463.4 7622.5 7623.4 7641.8 7661.3 2067.5 2104.5 2108.0 2111.7 2112.7 2067.6 2099.5 2109.4 2117.2 2121.8 2054.2 2084.1 2105.8 2105.8 2114.2 2064.3 2066.1 2076.7 2081.5 2082.2 1813.2 1869.6 2023.7 2041.0 2105.3 7094.2 7296.3 7312.2 7436.5 7446.3 4401.3 4493.6 4527.6 4538.5 4550.0 2834.3 2892.0 2912.7 2994.0 2995.0 970.1 982.6 994.5 1003.3 1006.5 9665.7 9916.4 9923.8 10012.7 10127.0 3800.6 3928.5 3953.2 3955.6 3972.7 7609.8 7671.0 7758.8 7759.0 7785.5 4380.3 4443.2 4444.7 4448.1 4468.8 4005.7 4080.5 4151.7 4180.3 4198.4 3205.8 3223.3 3292.9 3321.9 3333.1 1001.8 1028.6 1038.8 1043.0 1046.8 806.9 817.8 842.7 854.4 859.1 4627.2 4780.1 4790.0 4791.5 4827.2 485.9 496.4 507.9 514.2 515.4 3222.9 3226.7 3231.5 3240.9 3358.0 7807.3 8096.0 8412.2 8789.3 8800.3 8822.7 8942.5 8945.0 8955.0 8956.0 6725.1 6954.3 7011.1 7020.9 7021.8 5150.9 5184.6 5207.1 5311.7 5348.8 8359.2 8396.6 8426.8 8499.6 8501.6 8193.4 8304.4 8378.8 8433.5 8442.1 6097.2 6138.9 6240.6 6242.8 6248.6 7108.3 7128.2 7172.9 7196.6 7198.7 6442.3 6519.5 6536.0 6681.8 6763.8 6437.1 6463.1 6481.1 6534.7 6541.6 5721.8 5773.4 5785.9 5819.6 5839.6 4313.3 4469.4 4547.6 4569.8 4585.6 4346.2 4372.0 4478.1 4501.3 4569.1 05:24:07 INFO - PROCESS | 29917 | 05:24:07 INFO - PROCESS | 29917 | [#4] prototype.html Cycles:180 Average:4259.24 Median:4884.90 stddev:1228.23 (25.1%) stddev-sans-first:1196.01 05:24:07 INFO - PROCESS | 29917 | Values: 344.2 352.3 353.2 354.6 356.4 4900.8 4947.6 5026.4 5036.3 5058.0 4954.3 4960.8 4969.7 4996.0 4999.4 3696.8 3839.5 3861.9 3869.2 3884.3 3851.2 3858.5 3867.3 3872.8 3890.2 3853.6 3857.2 3867.5 3869.8 3875.3 3642.4 3812.6 3873.0 3883.3 3889.9 3368.1 3378.7 3378.8 3392.4 3401.3 4806.6 4811.0 4817.7 4822.5 4847.4 4387.8 4401.3 4408.2 4424.5 4445.0 4972.8 5127.3 5188.1 5201.8 5207.7 3672.5 3680.8 3695.7 3707.1 3713.9 5235.0 5429.6 5441.4 5471.9 5472.1 3731.6 3737.6 3743.4 3756.9 3767.8 3768.3 3776.7 3790.4 3827.5 3827.6 4377.9 4380.1 4388.2 4389.6 4392.6 5114.8 5205.2 5231.6 5257.3 5257.8 1259.9 1273.7 1275.1 1277.4 1285.7 839.4 885.8 889.6 896.4 900.3 4348.5 4354.0 4355.3 4356.0 4386.3 5162.5 5172.8 5206.3 5217.4 5254.6 4138.4 4333.2 4364.3 4380.3 4402.6 2762.3 2777.7 2782.9 2790.2 2798.7 4920.9 4936.6 4967.2 4969.8 4983.3 5057.4 5321.9 5352.5 5366.4 5386.5 4879.9 4883.0 4916.1 4922.5 4927.4 5130.7 5179.7 5188.1 5195.1 5208.7 4886.8 5061.2 5087.2 5107.0 5140.9 4847.4 4857.4 4859.2 4889.8 4996.3 3736.8 3769.3 3813.5 3815.9 3821.1 5268.4 5303.3 5305.5 5306.7 5313.2 4802.4 4988.0 5031.3 5053.5 5070.9 5022.7 5032.3 5040.4 5051.8 5057.6 5124.3 5129.5 5142.7 5149.8 5158.0 4998.6 5164.3 5182.0 5213.6 5241.7 5056.2 5082.9 5085.4 5099.8 5116.2 05:24:07 INFO - PROCESS | 29917 | 05:24:07 INFO - PROCESS | 29917 | [#5] yui.html Cycles:180 Average:14067.13 Median:23984.36 stddev:17089.63 (71.3%) stddev-sans-first:17107.54 05:24:07 INFO - PROCESS | 29917 | Values: 575.7 582.8 687.5 694.2 701.4 11150.9 12396.3 12412.5 12422.2 12522.3 12651.6 12667.7 12691.2 12797.4 12833.6 788.5 791.7 809.0 809.8 815.8 827.4 832.7 832.9 834.2 837.0 857.4 858.7 860.0 860.5 862.1 848.6 848.7 850.2 853.3 853.3 621.5 621.6 624.6 625.2 625.8 13033.5 13230.0 13355.3 13365.4 13385.2 12751.4 13020.3 13223.9 13361.8 13489.9 9124.5 9198.2 9247.5 9302.5 9313.6 3140.4 3154.5 3175.4 3310.9 3323.4 64306.7 64372.0 66193.3 66533.7 67202.7 10022.8 10063.3 10071.9 10237.4 10338.6 19168.7 19187.0 19190.1 19275.1 19345.9 5617.6 5624.9 5649.3 5714.1 5815.0 3268.3 3309.2 3352.7 3378.5 3404.9 2920.3 2961.2 2995.4 3006.0 3017.5 477.2 479.0 482.7 490.5 492.3 567.6 594.2 596.6 603.5 608.7 7820.0 7910.6 8010.8 8474.7 9140.3 451.5 460.8 477.7 547.1 565.6 3824.8 3917.0 4039.7 4137.9 4207.3 52027.2 52763.5 54404.2 58419.1 59300.1 50122.5 51674.0 52022.2 52164.0 53015.2 47491.5 47952.0 48634.5 48671.5 49233.3 8379.4 8737.6 8759.4 8830.3 8910.8 33044.7 33097.7 34686.3 35118.0 35145.0 38434.0 40644.6 41253.2 41638.0 41802.2 12578.2 12638.1 12640.7 12722.6 12921.9 11649.6 11774.8 12468.6 12476.8 13553.5 10115.1 10948.2 10991.7 11366.5 11922.2 10969.7 11646.5 11650.6 11790.6 12101.3 10431.4 10987.6 11136.0 11202.4 11506.7 9549.0 9906.0 10102.5 10128.5 10146.7 8188.0 8820.1 8939.9 8993.5 9674.2 05:24:07 INFO - PROCESS | 29917 | -------- Summary: end -------- 05:24:07 INFO - PROCESS | 29917 | 05:24:08 INFO - TEST-INFO | 29917: exit 0 05:24:08 INFO - TEST-OK | dromaeo_css | took 1120891ms 05:24:08 INFO - TEST-START | kraken 05:24:08 INFO - operating with platform_type : linux_ 05:24:08 INFO - Initialising browser for kraken test... 05:24:08 INFO - TEST-INFO | started process 30275 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSNr8MT/profile http://localhost:55259/getInfo.html) 05:24:12 INFO - PROCESS | 30275 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 05:24:12 INFO - PROCESS | 30275 | __metrics Screen width/height:1600/1200 05:24:12 INFO - PROCESS | 30275 | colorDepth:24 05:24:12 INFO - PROCESS | 30275 | Browser inner width/height: 1024/697 05:24:12 INFO - PROCESS | 30275 | __metrics 05:24:13 INFO - PROCESS | 30275 | 1486128253152 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:6301:36 < canClose@browser.js:5167:12 < forceQuit@jar:file:///tmp/tmpSNr8MT/profile/extensions/talos-powers@TalosPowersService.js:238:7 < whenDone@jar:file:///tmp/tmpSNr8MT/profile/extensions/talos-powers@TalosPowersService.js:223:9 < promise callback*forceQuit@jar:file:///tmp/tmpSNr8MT/profile/extensions/talos-powers@TalosPowersService.js:225:7 < receiveMessage@jar:file:///tmp/tmpSNr8MT/profile/extensions/talos-powers@TalosPowersService.js:55:9 05:24:13 ERROR - PROCESS | 30275 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3283: TypeError: this.tabs is undefined 05:24:14 INFO - TEST-INFO | 30275: exit 0 05:24:14 INFO - Browser initialized. 05:24:14 INFO - Running cycle 1/1 for kraken test... 05:24:14 INFO - TEST-INFO | started process 30394 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSNr8MT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:24:26 INFO - PROCESS | 30394 | RSS: Main: 159420416 05:24:26 INFO - PROCESS | 30394 | 05:24:29 INFO - PROCESS | 30394 | Cycle 1(1): loaded http://localhost:55259/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55259/tests/kraken/driver.html?testName=audio-beat-detection) 05:24:30 INFO - PROCESS | 30394 | RSS: Main: 166256640 05:24:30 INFO - PROCESS | 30394 | 05:24:32 INFO - PROCESS | 30394 | Cycle 1(1): loaded http://localhost:55259/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55259/tests/kraken/driver.html?testName=audio-dft) 05:24:33 INFO - PROCESS | 30394 | RSS: Main: 164741120 05:24:33 INFO - PROCESS | 30394 | 05:24:36 INFO - PROCESS | 30394 | Cycle 1(1): loaded http://localhost:55259/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55259/tests/kraken/driver.html?testName=audio-fft) 05:24:37 INFO - PROCESS | 30394 | RSS: Main: 161570816 05:24:37 INFO - PROCESS | 30394 | 05:24:39 INFO - PROCESS | 30394 | Cycle 1(1): loaded http://localhost:55259/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55259/tests/kraken/driver.html?testName=audio-oscillator) 05:24:39 INFO - PROCESS | 30394 | RSS: Main: 162136064 05:24:39 INFO - PROCESS | 30394 | 05:24:42 INFO - PROCESS | 30394 | Cycle 1(1): loaded http://localhost:55259/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55259/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:24:42 INFO - PROCESS | 30394 | RSS: Main: 162172928 05:24:42 INFO - PROCESS | 30394 | 05:24:45 INFO - PROCESS | 30394 | Cycle 1(1): loaded http://localhost:55259/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55259/tests/kraken/driver.html?testName=imaging-darkroom) 05:24:46 INFO - PROCESS | 30394 | RSS: Main: 167178240 05:24:46 INFO - PROCESS | 30394 | 05:24:50 INFO - PROCESS | 30394 | Cycle 1(1): loaded http://localhost:55259/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55259/tests/kraken/driver.html?testName=imaging-desaturate) 05:24:50 INFO - PROCESS | 30394 | RSS: Main: 163328000 05:24:50 INFO - PROCESS | 30394 | 05:24:53 INFO - PROCESS | 30394 | Cycle 1(1): loaded http://localhost:55259/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55259/tests/kraken/driver.html?testName=json-parse-financial) 05:24:54 INFO - PROCESS | 30394 | RSS: Main: 164909056 05:24:54 INFO - PROCESS | 30394 | 05:24:56 INFO - PROCESS | 30394 | Cycle 1(1): loaded http://localhost:55259/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55259/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:24:56 INFO - PROCESS | 30394 | RSS: Main: 165171200 05:24:56 INFO - PROCESS | 30394 | 05:24:58 INFO - PROCESS | 30394 | Cycle 1(1): loaded http://localhost:55259/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55259/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:24:59 INFO - PROCESS | 30394 | RSS: Main: 165339136 05:24:59 INFO - PROCESS | 30394 | 05:25:01 INFO - PROCESS | 30394 | Cycle 1(1): loaded http://localhost:55259/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55259/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:25:02 INFO - PROCESS | 30394 | RSS: Main: 165642240 05:25:02 INFO - PROCESS | 30394 | 05:25:04 INFO - PROCESS | 30394 | Cycle 1(1): loaded http://localhost:55259/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55259/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:25:05 INFO - PROCESS | 30394 | RSS: Main: 165957632 05:25:05 INFO - PROCESS | 30394 | 05:25:08 INFO - PROCESS | 30394 | Cycle 1(1): loaded http://localhost:55259/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55259/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:25:09 INFO - PROCESS | 30394 | RSS: Main: 165666816 05:25:09 INFO - PROCESS | 30394 | 05:25:11 INFO - PROCESS | 30394 | Cycle 1(1): loaded http://localhost:55259/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55259/tests/kraken/driver.html?testName=ai-astar) 05:25:11 INFO - PROCESS | 30394 | RSS: Main: 167411712 05:25:11 INFO - PROCESS | 30394 | 05:25:11 INFO - PROCESS | 30394 | __start_tp_report 05:25:11 INFO - PROCESS | 30394 | _x_x_mozilla_page_load 05:25:11 INFO - PROCESS | 30394 | _x_x_mozilla_page_load_details 05:25:11 INFO - PROCESS | 30394 | |i|pagename|runs| 05:25:11 INFO - PROCESS | 30394 | |0;ai-astar;109;116;117;117;116;118;118;116;116;118 05:25:11 INFO - PROCESS | 30394 | |1;audio-beat-detection;150;127;127;169;126;127;127;126;161;130 05:25:11 INFO - PROCESS | 30394 | |2;audio-dft;168;170;171;171;168;166;162;166;164;163 05:25:11 INFO - PROCESS | 30394 | |3;audio-fft;76;77;77;114;77;77;77;77;97;78 05:25:11 INFO - PROCESS | 30394 | |4;audio-oscillator;85;84;112;85;84;85;99;84;85;112 05:25:11 INFO - PROCESS | 30394 | |5;imaging-gaussian-blur;119;119;119;118;123;119;118;118;120;118 05:25:11 INFO - PROCESS | 30394 | |6;imaging-darkroom;151;151;151;151;150;150;150;152;151;150 05:25:11 INFO - PROCESS | 30394 | |7;imaging-desaturate;95;97;96;97;97;99;98;96;96;96 05:25:11 INFO - PROCESS | 30394 | |8;json-parse-financial;67;67;67;69;69;68;67;67;68;67 05:25:11 INFO - PROCESS | 30394 | |9;json-stringify-tinderbox;65;66;65;66;65;65;66;65;65;66 05:25:11 INFO - PROCESS | 30394 | |10;stanford-crypto-aes;87;87;89;88;89;87;87;91;86;87 05:25:11 INFO - PROCESS | 30394 | |11;stanford-crypto-ccm;147;136;135;136;143;145;135;134;186;135 05:25:11 INFO - PROCESS | 30394 | |12;stanford-crypto-pbkdf2;185;176;178;179;177;189;187;181;184;184 05:25:11 INFO - PROCESS | 30394 | |13;stanford-crypto-sha256-iterative;70;69;69;68;70;68;68;67;66;68 05:25:11 INFO - PROCESS | 30394 | __end_tp_report 05:25:11 INFO - PROCESS | 30394 | __start_cc_report 05:25:11 INFO - PROCESS | 30394 | _x_x_mozilla_cycle_collect,900 05:25:11 INFO - PROCESS | 30394 | __end_cc_report 05:25:11 INFO - PROCESS | 30394 | __startTimestamp1486128311460__endTimestamp 05:25:11 INFO - PROCESS | 30394 | 05:25:11 INFO - PROCESS | 30394 | ------- Summary: start ------- 05:25:11 INFO - PROCESS | 30394 | Number of tests: 14 05:25:11 INFO - PROCESS | 30394 | 05:25:11 INFO - PROCESS | 30394 | [#0] ai-astar Cycles:10 Average:116.10 Median:117.00 stddev:2.64 (2.3%) stddev-sans-first:0.93 05:25:11 INFO - PROCESS | 30394 | Values: 109.0 116.0 117.0 117.0 116.0 118.0 118.0 116.0 116.0 118.0 05:25:11 INFO - PROCESS | 30394 | 05:25:11 INFO - PROCESS | 30394 | [#1] audio-beat-detection Cycles:10 Average:137.00 Median:128.50 stddev:16.53 (12.9%) stddev-sans-first:16.85 05:25:11 INFO - PROCESS | 30394 | Values: 150.0 127.0 127.0 169.0 126.0 127.0 127.0 126.0 161.0 130.0 05:25:11 INFO - PROCESS | 30394 | 05:25:11 INFO - PROCESS | 30394 | [#2] audio-dft Cycles:10 Average:166.90 Median:168.00 stddev:3.25 (1.9%) stddev-sans-first:3.42 05:25:11 INFO - PROCESS | 30394 | Values: 168.0 170.0 171.0 171.0 168.0 166.0 162.0 166.0 164.0 163.0 05:25:11 INFO - PROCESS | 30394 | 05:25:11 INFO - PROCESS | 30394 | [#3] audio-fft Cycles:10 Average:82.70 Median:77.00 stddev:12.68 (16.5%) stddev-sans-first:13.21 05:25:11 INFO - PROCESS | 30394 | Values: 76.0 77.0 77.0 114.0 77.0 77.0 77.0 77.0 97.0 78.0 05:25:11 INFO - PROCESS | 30394 | 05:25:11 INFO - PROCESS | 30394 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:85.00 stddev:11.71 (13.8%) stddev-sans-first:12.18 05:25:11 INFO - PROCESS | 30394 | Values: 85.0 84.0 112.0 85.0 84.0 85.0 99.0 84.0 85.0 112.0 05:25:11 INFO - PROCESS | 30394 | 05:25:11 INFO - PROCESS | 30394 | [#5] imaging-gaussian-blur Cycles:10 Average:119.10 Median:119.00 stddev:1.52 (1.3%) stddev-sans-first:1.62 05:25:11 INFO - PROCESS | 30394 | Values: 119.0 119.0 119.0 118.0 123.0 119.0 118.0 118.0 120.0 118.0 05:25:11 INFO - PROCESS | 30394 | 05:25:11 INFO - PROCESS | 30394 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 05:25:11 INFO - PROCESS | 30394 | Values: 151.0 151.0 151.0 151.0 150.0 150.0 150.0 152.0 151.0 150.0 05:25:11 INFO - PROCESS | 30394 | 05:25:11 INFO - PROCESS | 30394 | [#7] imaging-desaturate Cycles:10 Average:96.70 Median:97.00 stddev:1.16 (1.2%) stddev-sans-first:1.05 05:25:11 INFO - PROCESS | 30394 | Values: 95.0 97.0 96.0 97.0 97.0 99.0 98.0 96.0 96.0 96.0 05:25:11 INFO - PROCESS | 30394 | 05:25:11 INFO - PROCESS | 30394 | [#8] json-parse-financial Cycles:10 Average:67.60 Median:67.50 stddev:0.84 (1.2%) stddev-sans-first:0.87 05:25:11 INFO - PROCESS | 30394 | Values: 67.0 67.0 67.0 69.0 69.0 68.0 67.0 67.0 68.0 67.0 05:25:11 INFO - PROCESS | 30394 | 05:25:11 INFO - PROCESS | 30394 | [#9] json-stringify-tinderbox Cycles:10 Average:65.40 Median:65.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 05:25:11 INFO - PROCESS | 30394 | Values: 65.0 66.0 65.0 66.0 65.0 65.0 66.0 65.0 65.0 66.0 05:25:11 INFO - PROCESS | 30394 | 05:25:11 INFO - PROCESS | 30394 | [#10] stanford-crypto-aes Cycles:10 Average:87.80 Median:87.50 stddev:1.48 (1.7%) stddev-sans-first:1.54 05:25:11 INFO - PROCESS | 30394 | Values: 87.0 87.0 89.0 88.0 89.0 87.0 87.0 91.0 86.0 87.0 05:25:11 INFO - PROCESS | 30394 | 05:25:11 INFO - PROCESS | 30394 | [#11] stanford-crypto-ccm Cycles:10 Average:143.20 Median:139.50 stddev:15.77 (11.3%) stddev-sans-first:16.67 05:25:11 INFO - PROCESS | 30394 | Values: 147.0 136.0 135.0 136.0 143.0 145.0 135.0 134.0 186.0 135.0 05:25:11 INFO - PROCESS | 30394 | 05:25:11 INFO - PROCESS | 30394 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.00 Median:184.00 stddev:4.45 (2.4%) stddev-sans-first:4.58 05:25:11 INFO - PROCESS | 30394 | Values: 185.0 176.0 178.0 179.0 177.0 189.0 187.0 181.0 184.0 184.0 05:25:11 INFO - PROCESS | 30394 | 05:25:11 INFO - PROCESS | 30394 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:1.25 (1.8%) stddev-sans-first:1.17 05:25:11 INFO - PROCESS | 30394 | Values: 70.0 69.0 69.0 68.0 70.0 68.0 68.0 67.0 66.0 68.0 05:25:11 INFO - PROCESS | 30394 | -------- Summary: end -------- 05:25:11 INFO - PROCESS | 30394 | 05:25:12 INFO - TEST-INFO | 30394: exit 0 05:25:12 INFO - TEST-OK | kraken | took 64408ms 05:25:12 INFO - SUITE-END | took 1185s 05:25:13 INFO - Completed test suite (00:19:45) 05:25:13 INFO - javascript benchmark 05:25:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6295.800831163687, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2579.9355016124605, 2581.5998520229364, 2583.48330333933, 2608.7391260873915, 2620.54140525408, 4696.201645720227, 4738.90522189556, 4756.120117778213, 4774.355462012627, 4817.22924332107, 4700.882477938053, 4733.8816529586775, 4787.257975013869, 4883.731394773286, 4967.056259310738, 4270.530241673429, 4368.432103826506, 4422.469303683562, 4582.885427864313, 4583.03756211196, 4487.977560112195, 4502.0, 4503.189425903336, 4527.683062185648, 4528.18492671319, 4338.934915976263, 4349.69552131351, 4380.3210502372185, 4406.867793966187, 4427.1367083418745, 4410.6030457259, 4412.536683648235, 4440.845380201139, 4448.043670610802, 4463.575960283768, 4321.567843215685, 4382.671299652538, 4383.495897971742, 4392.407025051641, 4430.069685366077, 4655.627549796008, 4688.29675548667, 4726.480087190406, 4748.95251047492, 4784.330193772875, 5061.013102445025, 5062.31658726071, 5065.848024559269, 5089.160288552422, 5122.487751224885, 5103.23451482277, 5119.0529751996, 5119.897602047976, 5127.230915362688, 5158.0, 4642.628589712815, 4695.976520117378, 4792.544708252711, 4798.064377446364, 4852.927206091911, 5263.842084737464, 5309.3894202166475, 5328.573714102862, 5335.439778823245, 5339.946600533945, 5058.367704036996, 5065.7720402581235, 5092.337996060489, 5116.9744151279, 5143.305653736773, 5123.6157288202785, 5162.819301324435, 5168.095583272912, 5178.0679477694375, 5217.34783152106, 5000.524950129805, 5085.211792172219, 5115.8721031973755, 5116.386033675983, 5151.5878729701535, 5028.371453568304, 5071.974640126776, 5085.364329458817, 5126.077306084941, 5166.8966620668125, 4268.061026574149, 4274.572542745701, 4303.483581970121, 4325.632321252666, 4353.847615333448, 3702.555693316819, 3753.11801726594, 3768.4158955361963, 3785.280796648628, 3799.2021675448464, 4258.510271318838, 4288.571142885687, 4352.042550638855, 4357.324614684729, 4377.343398490252, 5171.81898633546, 5206.088934436459, 5215.348081489814, 5253.1857562077175, 5261.0, 4356.128774245164, 4380.8904777380185, 4398.362237475612, 4403.3174857897075, 4458.6878918475395, 4406.9559304407185, 4652.813887444464, 4657.4876763555985, 4658.767061646904, 4685.0629874025335, 4734.573888350065, 4843.612510999041, 4877.5366340197625, 4886.682365646222, 4913.0, 5037.319961805109, 5043.193089105725, 5049.34358533403, 5052.69683818972, 5113.53978141969, 4780.665353425227, 4793.688410253322, 4798.064377446364, 4799.496052914394, 4867.342908707279, 4948.430930442901, 5030.496950304941, 5050.3182070420025, 5054.620903432184, 5059.494050594911, 4963.875903102451, 4985.077760614298, 5022.397312322545, 5025.572826309804, 5030.119729047329, 4764.166270902648, 4783.354247176726, 4788.760561971957, 4798.184308667465, 4808.447028591617, 4810.062037902575, 4843.685160464699, 4849.2726091086615, 4863.4650188479945, 4873.0, 4805.37530121082, 4913.41039075299, 4916.041371932439, 4953.603711703127, 4958.925616115689, 4936.506349365035, 4968.850934471971, 4991.825286114969, 4997.675151115166, 5007.7746501408255, 4810.735409552508, 4828.517148285284, 4837.7097374157665, 4881.389826271716, 4930.6055515557955], "value": 4679.787338570125, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [542.2923085373587, 542.5090293284579, 561.5479538971126, 568.0967262053334, 570.7716913234706, 41012.43800991842, 42961.35557966633, 43059.35410968838, 43059.78470107649, 43101.56898431015, 38949.221015579744, 40186.39720404196, 40225.7988710056, 40296.0, 40367.0, 7615.885761713579, 7733.961330193341, 7760.379169666413, 9018.503982280972, 9269.304802139834, 9211.861822072675, 9212.723618291462, 9262.0, 9281.071892810698, 9312.860307095365, 9249.35254532183, 9279.0720927907, 9320.161185493303, 9326.207272381822, 9340.626374945028, 9243.352965292432, 9270.768230794216, 9308.0, 9328.0, 9344.719658410258, 9190.080991900822, 9199.448033117967, 9258.166764991183, 9308.743319651896, 9330.206932410752, 32803.50794738081, 32947.176320591934, 32971.6702832971, 33113.66886331154, 33117.17855517945, 3263.8368081596063, 3350.329934013207, 3370.0900756795772, 3404.0468668772783, 3404.9489257661153, 25027.37431564207, 25209.62185567218, 25260.0, 26199.34501637455, 26463.0, 2824.1962766514803, 2944.6319210098736, 3005.8196508209576, 3010.1872494426602, 3087.799293045945, 249373.0, 250332.0, 252176.0, 252281.0, 252659.0, 39524.209515809525, 40472.79763601163, 45800.0, 46312.5368746315, 46675.76662116668, 45167.774161129644, 48921.0, 49131.754341228065, 49339.25991110136, 49409.752951235016, 13270.535531256359, 13362.465501380031, 13431.597052088258, 13437.865621343857, 13439.0, 10095.0, 10157.695269141937, 10162.796744065225, 10168.237382196365, 10181.54183061764, 15479.613009674624, 15587.844121558866, 15625.761228903175, 15632.609184770472, 15731.292091855894, 6313.337099604567, 6562.2453417856605, 6619.669016549154, 6623.635700036448, 6682.766103186463, 746.8879668049836, 749.1197842534999, 752.6236881559221, 770.4683768199924, 776.1811289090065, 25888.223353299432, 26673.33316667099, 27108.59337109945, 27185.45629087407, 27352.863235683693, 899.8605216191501, 914.6021480655936, 915.8763566918514, 920.0477505781485, 949.2263804999042, 13966.650833729034, 14158.787618185735, 14351.78472322916, 14544.63638409027, 14647.414103435956, 353532.0, 357026.0, 358717.0, 359255.0, 359646.0, 49610.255846162334, 50013.74993125011, 50151.498485015414, 50243.0, 50258.0, 1201.201201201209, 1201.2277037429178, 1226.8282440458343, 1237.888590026884, 1238.9504419823286, 25043.373915652253, 25647.358816029748, 26634.0, 26781.0, 26908.461830762884, 41652.375214371204, 41935.16129677328, 42044.36933446062, 42078.789606051774, 42223.0, 296106.0, 296784.0, 297372.0, 298402.0, 299293.0, 23893.880530597235, 24975.75024249807, 24998.875005624854, 25008.249752507454, 25120.59907119905, 39167.0, 39261.214775704895, 40327.59672403238, 40641.1871762569, 41072.38391424191, 34126.65873341235, 34257.0, 34514.309713806084, 34991.30017399689, 35083.64916350906, 34093.0, 34309.48535771915, 34428.65571344355, 34715.65284347225, 34716.826415867756, 33414.0, 33617.83191084029, 33667.97992120481, 33830.0, 34079.0, 28545.28636784097, 31077.0, 31090.22274443157, 31169.376612468077, 31208.843955780078, 23302.88348558314, 23390.64914026325, 23642.881785590962, 23737.9317930697, 23832.523349533258], "value": 17013.69569355943, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.9737518373715, 384.7821110412982, 390.3598099117446, 392.89784655989445, 412.8885200995731, 16511.587210319747, 17378.0, 18042.819571804295, 18091.72862407065, 18804.62390752184, 17492.912535437306, 17637.089880169755, 17760.0, 17991.280348786066, 18096.909515452404, 5030.471800460963, 5079.288899554047, 5246.816361427351, 5252.65857719247, 5263.315768950031, 5078.263651770491, 5164.147915593922, 5174.120399532088, 5198.142306519419, 5222.00781851447, 4947.752612369385, 5140.768665410065, 5153.1754919212935, 5173.844784656466, 5188.429272779991, 4948.480409556999, 5101.107306221415, 5122.795088196468, 5129.025485157808, 5140.665856719302, 4604.450704504769, 4616.746078965655, 4635.976820115911, 4637.466691330473, 4643.698159619614, 21359.57280854374, 21394.251201207884, 21660.35018949434, 21675.024623891964, 21758.238461653924, 2097.528056187361, 2141.757313862809, 2157.6224160771803, 2159.276642324823, 2164.632012557869, 13617.455301787917, 13700.177989320673, 13743.450261989508, 13761.931190344085, 14280.428782848778, 1742.9041402722846, 1764.2061072517417, 1846.4645252876649, 1847.6581832361055, 1864.459306801026, 67178.66410667915, 76047.23952760457, 77075.22924770736, 77285.0, 78741.8817776837, 10126.189904807597, 10161.0, 10767.89232107669, 11025.779484410266, 11143.164262680331, 15252.542423727306, 15253.6186595336, 15288.235588220545, 15294.923525382303, 15314.243436181372, 6891.517593768388, 7059.89410158848, 7062.929370706227, 7236.529625574321, 7329.120505539369, 6499.642519661369, 6600.240972288152, 6753.729850805913, 6759.526833121733, 6775.085363475868, 4242.6817988650355, 4338.544452832471, 4558.179527685049, 4689.577937985598, 4799.232122860326, 1829.3863809036618, 1962.5878565501405, 1974.6051038859564, 2017.7477815273091, 2024.22067504012, 927.1609193679731, 935.2798345274236, 952.8713623660717, 975.7121649113528, 988.2242439684813, 16887.493375198763, 17629.7355539667, 17945.461636150936, 17973.1013449327, 18242.270309187483, 946.2382781860531, 953.9618415263312, 954.2032402943481, 957.7988622389237, 968.7529679931572, 9178.541072946326, 9669.516524173763, 9727.07592778685, 9738.659146929824, 9917.75205619851, 444448.0, 445971.0, 448990.0, 461721.0, 482010.0, 71972.28027719655, 74878.0, 90345.54827225822, 90662.54668726613, 92118.53940730254, 917.6696389299847, 919.5999740112939, 937.8311903857372, 945.2957546627806, 952.066974365126, 15097.698046039237, 15148.16685082287, 15500.92249538745, 15736.60658483547, 15888.205589720237, 39432.21135577215, 39567.80216098901, 40476.0, 40783.796081019405, 40795.572154974434, 51446.485535145664, 51770.48229517657, 53196.0, 54832.72583637056, 54857.177142343695, 7324.487285889936, 7460.925390746023, 7677.61611919413, 7774.2614451627005, 8113.1886811320755, 10379.377237365783, 12887.484500620245, 12889.613311600668, 12891.548795792101, 12940.676483087998, 10028.849567256642, 10163.390196588229, 10262.43556604394, 10540.57837686484, 10655.573777049141, 10356.430396328275, 10485.423301718478, 10721.463926803784, 10824.512896919816, 10928.78142437131, 9786.0, 10442.738931526772, 10451.895481045092, 10543.0, 10926.617568385069, 6255.0, 6441.291457939529, 7854.0, 7896.68413263463, 8293.95853020731, 7961.482503637245, 9653.03469653029, 9656.855147172939, 9679.386565627383, 9744.951275243578], "value": 8535.301019792472, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1332.4869925078847, 1338.2773302416695, 1340.792177212532, 1347.6226656536162, 1350.8649135086494, 7236.167840698315, 7347.302006309405, 7599.316061554473, 7708.0, 7713.0, 7463.440241981846, 7622.542647441157, 7623.428242881779, 7641.808954776119, 7661.310482056628, 2067.524469372045, 2104.547522282709, 2108.0, 2111.6938043983614, 2112.661974084147, 2067.55129060195, 2099.5276062885882, 2109.3882773995524, 2117.1743020222048, 2121.7984291492285, 2054.189295181734, 2084.0725876984748, 2105.768365479796, 2105.799949004842, 2114.164904862578, 2064.3394113883564, 2066.142550841399, 2076.698878662593, 2081.458820706627, 2082.2295750572384, 1813.2475022865494, 1869.6354210928873, 2023.6660950943076, 2040.9693854592044, 2105.3157723739846, 7094.219635840053, 7296.270372962715, 7312.1956584775635, 7436.516626419266, 7446.329830315298, 4401.295792673189, 4493.595576398107, 4527.569880861313, 4538.546145385468, 4550.0, 2834.291427143214, 2892.0, 2912.723291287324, 2993.985030074836, 2994.970050299491, 970.0929630795229, 982.6069572171117, 994.4778991029694, 1003.3127307794184, 1006.4816619440994, 9665.71002869915, 9916.355436896578, 9923.751906202402, 10012.749681258027, 10127.0, 3800.56293526248, 3928.4500169976227, 3953.150072734376, 3955.5846636102797, 3972.741771784825, 7609.847803043908, 7670.96164519185, 7758.7672369829, 7759.030121234846, 7785.455018148788, 4380.299152135643, 4443.178012067778, 4444.688871778944, 4448.088141930896, 4468.821247150077, 4005.6595189408645, 4080.5103387593085, 4151.73013754105, 4180.310248808913, 4198.412222288882, 3205.7755957083245, 3223.339215460825, 3292.9176770580925, 3321.9003429897143, 3333.0500807269814, 1001.7846163074973, 1028.6451174344838, 1038.8337865941412, 1043.0, 1046.8325067989085, 806.8830019647236, 817.811903262253, 842.7316888083518, 854.4189950833369, 859.0807835615956, 4627.190241707688, 4780.139574876555, 4789.95210047902, 4791.47293797689, 4827.2035114206465, 485.9319695242669, 496.377046806263, 507.908576456234, 514.1875836178829, 515.3789683431456, 3222.9194270143435, 3226.6934641209045, 3231.4506533889294, 3240.8703651854134, 3357.9832100839826, 7807.258310460497, 8096.02847658273, 8412.158784121539, 8789.252913502296, 8800.33997450181, 8822.691205807894, 8942.46345219289, 8944.955275223712, 8954.955225223963, 8956.0, 6725.125733654593, 6954.3045695431065, 7011.123609548807, 7020.92979070213, 7021.754238601625, 5150.922736159036, 5184.559312458332, 5207.140821764367, 5311.734413279398, 5348.839534813962, 8359.164083591591, 8396.622152003052, 8426.789330266547, 8499.57502124879, 8501.574921254036, 8193.426460147732, 8304.377171712025, 8378.790530236793, 8433.493990360597, 8442.113578074459, 6097.237845269341, 6138.907916381168, 6240.594361366497, 6242.781502647385, 6248.625082495065, 7108.324709152622, 7128.180259270251, 7172.856542869218, 7196.640167991684, 7198.748043818441, 6442.323556026738, 6519.478441724746, 6536.0, 6681.799546013627, 6763.7632682855865, 6437.0666253392055, 6463.095166676575, 6481.125048118443, 6534.738610455529, 6541.574797638138, 5721.828345149652, 5773.422657734193, 5785.942140578541, 5819.563532734977, 5839.591228613956, 4313.309870420718, 4469.41897553329, 4547.590716835369, 4569.840055598171, 4585.564371384713, 4346.195953748566, 4372.0, 4478.104379124123, 4501.3022981437925, 4569.063342014945], "value": 3869.0462217311474, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.1705489769655, 352.3094734320731, 353.189430257559, 354.6435831988851, 356.35677601928523, 4900.754962251891, 4947.554720075193, 5026.447090820011, 5036.269740887574, 5057.974710126444, 4954.331165292684, 4960.776765045573, 4969.676970996883, 4995.950040499594, 4999.4000719913665, 3696.7597106188146, 3839.520059992501, 3861.8800547841092, 3869.187470631171, 3884.3396622574087, 3851.2490064437447, 3858.5369755629363, 3867.284552357809, 3872.845086196563, 3890.1830615570766, 3853.5761066282685, 3857.2092720992127, 3867.4972253606993, 3869.806509674519, 3875.302445559798, 3642.359289515107, 3812.6377994090517, 3872.9806350968206, 3883.320418926705, 3889.883303500885, 3368.0970251807894, 3378.712809411203, 3378.831058447068, 3392.3724111039537, 3401.268727223659, 4806.615470762331, 4811.0, 4817.686850354716, 4822.469528351879, 4847.394075740533, 4387.824487020515, 4401.339799030139, 4408.184485870092, 4424.535423780489, 4444.955435472693, 4972.776225069881, 5127.3083379966365, 5188.092083885305, 5201.791928322863, 5207.724107593664, 3672.485851980725, 3680.834362453696, 3695.667389934892, 3707.14735610811, 3713.925721485555, 5234.973825130888, 5429.647072940246, 5441.401445840955, 5471.945280547223, 5472.124460086367, 3731.589525152231, 3737.570179429346, 3743.382341913554, 3756.9436458453147, 3767.7927713975446, 3768.3217020936495, 3776.678982286536, 3790.431435284674, 3827.5406951166037, 3827.61723827615, 4377.9124417511475, 4380.145871555016, 4388.166248412791, 4389.551448022145, 4392.582704643118, 5114.849158939209, 5205.241222152265, 5231.567321195586, 5257.342832145981, 5257.842264732064, 1259.8614152443224, 1273.6690158784093, 1275.113795911851, 1277.4251586785797, 1285.6528737240892, 839.3956351427084, 885.8449771289999, 889.6263569300909, 896.4083704754961, 900.2707806676613, 4348.499922508889, 4353.978230108829, 4355.346697995263, 4355.9981204323185, 4386.298192289282, 5162.496189348163, 5172.793088276427, 5206.323177986913, 5217.373915130209, 5254.632175747737, 4138.441310423114, 4333.1651488432335, 4364.3017117261725, 4380.299152135643, 4402.647788176938, 2762.267998980272, 2777.666679998413, 2782.9304267393477, 2790.2047916343745, 2798.720127987185, 4920.926186107211, 4936.580390666762, 4967.230079337708, 4969.807246260872, 4983.27742477346, 5057.443681195065, 5321.920171197435, 5352.464753524694, 5366.382865970385, 5386.5152136307925, 4879.902401951941, 4883.0, 4916.139675556763, 4922.4585295616735, 4927.353758218964, 5130.74296797287, 5179.715115668674, 5188.118019936695, 5195.142801437721, 5208.687478751287, 4886.804527818847, 5061.190209566452, 5087.202038878676, 5106.974465127651, 5140.871478213075, 4847.418309802846, 4857.441394239708, 4859.202095224789, 4889.7799599018845, 4996.325496057985, 3736.8318425671455, 3769.3026790043928, 3813.504244448204, 3815.9427608586448, 3821.1085512670293, 5268.446813084724, 5303.2840566524565, 5305.549028332635, 5306.681599103912, 5313.1764576490705, 4802.423709154924, 4987.977464619672, 5031.3207716959205, 5053.469385714594, 5070.949290507047, 5022.723750193774, 5032.3206367139965, 5040.395152581714, 5051.823186188466, 5057.645964782577, 5124.333836601218, 5129.538341549279, 5142.665726727751, 5149.768260428365, 5158.0, 4998.625103117353, 5164.302819119521, 5181.974090129525, 5213.6350455467755, 5241.7379131042535, 5056.191009438472, 5082.872928176677, 5085.4406015337545, 5099.79600815978, 5116.181410974226], "value": 3881.1792784702475, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.6833741442211, 582.8455459303283, 687.4912564702121, 694.2086021934991, 701.3967987530724, 11150.888491115087, 12396.318202498858, 12412.503499860006, 12422.192557483757, 12522.311272879988, 12651.557195498159, 12667.683307917307, 12691.238525688465, 12797.360131993386, 12833.588305286434, 788.5229436191108, 791.707068384697, 808.9676412943476, 809.8056466448069, 815.7552734179752, 827.3711978896052, 832.7043899415711, 832.937529685273, 834.1866679986995, 836.9579873058021, 857.4126723194601, 858.7295002074358, 859.995700021499, 860.4665107633276, 862.1249431826701, 848.5969164646805, 848.6775025490305, 850.2220468271524, 853.2534032721369, 853.3301358433599, 621.4934828115117, 621.5835390288518, 624.6096189881324, 625.190378459891, 625.809128215894, 13033.543825966046, 13230.0, 13355.265460399674, 13365.398557064955, 13385.19688818674, 12751.362431878462, 13020.348982550835, 13223.933880330633, 13361.799573006412, 13489.932550337284, 9124.5437728114, 9198.17216450516, 9247.537623118884, 9302.488363140024, 9313.58088885995, 3140.434721750084, 3154.511050787132, 3175.3966746318124, 3310.9172270693184, 3323.3685599736214, 64306.678466607365, 64372.0, 66193.3380666192, 66533.66733166351, 67202.66398667975, 10022.799544009078, 10063.295569310225, 10071.899281007243, 10237.436940968319, 10338.638147664795, 19168.71246931297, 19187.0, 19190.13644386006, 19275.132619032178, 19345.90327048356, 5617.606767526234, 5624.91562626561, 5649.322081350264, 5714.114312281603, 5815.040518314515, 3268.264640455878, 3309.2223327518013, 3352.6814952579466, 3378.527006219131, 3404.863805447754, 2920.313726274324, 2961.1560705198913, 2995.445842519141, 3006.0, 3017.5021121514706, 477.1983068444976, 478.99760501197966, 482.6549017452538, 490.52419153421124, 492.26406522249465, 567.6055141676578, 594.174098003775, 596.6122020686588, 603.5473394953784, 608.6500262349167, 7819.960900195576, 7910.564918929399, 8010.838428427845, 8474.74575762728, 9140.268778497837, 451.51687694166924, 460.8479201863377, 477.73485715428274, 547.0945585056737, 565.6210339072832, 3824.7896365700153, 3916.980415097906, 4039.6970227233073, 4137.855175068858, 4207.26372884744, 52027.219591706154, 52763.472365276626, 54404.183937240974, 58419.123713144334, 59300.11049834256, 50122.49877501178, 51674.0, 52022.21966670427, 52164.0, 53015.20477192845, 47491.5250847494, 47952.0, 48634.51365486371, 48671.5132848667, 49233.2615010768, 8379.41344105931, 8737.56312184401, 8759.430637008574, 8830.337724670548, 8910.777230569029, 33044.66955330416, 33097.669023310424, 34686.30627387387, 35118.0, 35145.0, 38434.0, 40644.59355406408, 41253.1749365017, 41638.0, 41802.163956720084, 12578.182418142791, 12638.115331927045, 12640.747185056063, 12722.61832145037, 12921.870781292067, 11649.59226427071, 11774.764504710029, 12468.625941221779, 12476.750464990468, 13553.457861685421, 10115.140213081677, 10948.233623646587, 10991.725206869893, 11366.488508017324, 11922.225055371373, 10969.670909872717, 11646.534138634359, 11650.592229271935, 11790.587329443428, 12101.273923564615, 10431.426271555138, 10987.61543345979, 11136.0, 11202.38386888729, 11506.654800356002, 9549.0, 9905.950470247892, 10102.545385457524, 10128.544215510467, 10146.695599132037, 8188.0, 8820.117988201386, 8939.910600893907, 8993.460392376479, 9674.17769489573], "value": 6101.603912519812, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 116.0, 117.0, 117.0, 116.0, 118.0, 118.0, 116.0, 116.0, 118.0], "value": 116.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 127.0, 127.0, 169.0, 126.0, 127.0, 127.0, 126.0, 161.0, 130.0], "value": 137.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 170.0, 171.0, 171.0, 168.0, 166.0, 162.0, 166.0, 164.0, 163.0], "value": 166.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 114.0, 77.0, 77.0, 77.0, 77.0, 97.0, 78.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 112.0, 85.0, 84.0, 85.0, 99.0, 84.0, 85.0, 112.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 119.0, 118.0, 123.0, 119.0, 118.0, 118.0, 120.0, 118.0], "value": 119.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 151.0, 151.0, 150.0, 150.0, 150.0, 152.0, 151.0, 150.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 97.0, 97.0, 99.0, 98.0, 96.0, 96.0, 96.0], "value": 96.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 69.0, 69.0, 68.0, 67.0, 67.0, 68.0, 67.0], "value": 67.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 66.0], "value": 65.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 89.0, 88.0, 89.0, 87.0, 87.0, 91.0, 86.0, 87.0], "value": 87.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 136.0, 135.0, 136.0, 143.0, 145.0, 135.0, 134.0, 186.0, 135.0], "value": 143.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 176.0, 178.0, 179.0, 177.0, 189.0, 187.0, 181.0, 184.0, 184.0], "value": 182.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 69.0, 68.0, 70.0, 68.0, 68.0, 67.0, 66.0, 68.0], "value": 68.3, "unit": "score"}]}]} 05:25:13 INFO - Return code: 0 05:25:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:25:13 ERROR - # TBPL SUCCESS # 05:25:13 INFO - Running post-action listener: _resource_record_post_action 05:25:13 INFO - [mozharness: 2017-02-03 13:25:13.246315Z] Finished run-tests step (success) 05:25:13 INFO - Running post-run listener: _resource_record_post_run 05:25:13 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8192; Write bytes: 398098432; Read time: 20; Write time: 258980 05:25:13 INFO - TinderboxPrint: CPU usage
13.5% 05:25:13 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 20 05:25:13 INFO - TinderboxPrint: I/O write bytes / time
398,098,432 / 258,980 05:25:13 INFO - TinderboxPrint: CPU idle
8,299.8 (86.5%) 05:25:13 INFO - TinderboxPrint: CPU user
1,234.8 (12.9%) 05:25:13 INFO - TinderboxPrint: Swap in / out
0 / 0 05:25:13 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 100278272; Read time: 0; Write time: 80936 05:25:13 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 297820160; Read time: 0; Write time: 178044 05:25:13 INFO - Running post-run listener: _upload_blobber_files 05:25:13 INFO - Blob upload gear active. 05:25:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:25:13 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:25:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:25:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:25:14 INFO - (blobuploader) - INFO - Open directory for files ... 05:25:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:25:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:25:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:15 INFO - (blobuploader) - INFO - Done attempting. 05:25:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:25:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:25:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:16 INFO - (blobuploader) - INFO - Done attempting. 05:25:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:25:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:19 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:25:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:19 INFO - (blobuploader) - INFO - Done attempting. 05:25:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:25:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:25:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:25:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:25:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:25:19 INFO - (blobuploader) - INFO - Done attempting. 05:25:19 INFO - (blobuploader) - INFO - Iteration through files over. 05:25:19 INFO - Return code: 0 05:25:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:25:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:25:19 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e0ed316b3ca179b4a5207884e09eb12a3f046201b777e55c4ba9cf83525adb60d7416ca4afe687b30dd41ec3aa5b9e557b3bf03953a9b68b2882d5378970d5f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bde39d34b6f6b8eb504e36ba654ffde0e012851098c52eeb65c81b8214700f47ff55888612ca4623fefbaf8bfab2a62f83c6367df9714ccff41d85d1ba43a150", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/706c00931fb1bce20feedb7180fb62817efef4fd879f10093cab7289d4084c00dcd37dfad3c14195aa8f76e7e29af9f2883a9e4adc45c18fb3965e95316a187e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/191b884e0ad5152d0bdbd5bd1506289403db3249dbdf4fd58371f62a8d0930e7d7b13df59f5c0852f84a17f9b530971c8a192c7b97d7fa450c8e678fdb727866"} 05:25:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:25:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:25:19 INFO - Contents: 05:25:19 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e0ed316b3ca179b4a5207884e09eb12a3f046201b777e55c4ba9cf83525adb60d7416ca4afe687b30dd41ec3aa5b9e557b3bf03953a9b68b2882d5378970d5f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bde39d34b6f6b8eb504e36ba654ffde0e012851098c52eeb65c81b8214700f47ff55888612ca4623fefbaf8bfab2a62f83c6367df9714ccff41d85d1ba43a150", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/706c00931fb1bce20feedb7180fb62817efef4fd879f10093cab7289d4084c00dcd37dfad3c14195aa8f76e7e29af9f2883a9e4adc45c18fb3965e95316a187e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/191b884e0ad5152d0bdbd5bd1506289403db3249dbdf4fd58371f62a8d0930e7d7b13df59f5c0852f84a17f9b530971c8a192c7b97d7fa450c8e678fdb727866"} 05:25:19 INFO - Running post-run listener: copy_logs_to_upload_dir 05:25:19 INFO - Copying logs to upload dir... 05:25:19 INFO - mkdir: /builds/slave/test/build/upload/logs 05:25:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.534086 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2017-02-03 05:25:19.595517) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 05:25:19.599407) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e0ed316b3ca179b4a5207884e09eb12a3f046201b777e55c4ba9cf83525adb60d7416ca4afe687b30dd41ec3aa5b9e557b3bf03953a9b68b2882d5378970d5f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bde39d34b6f6b8eb504e36ba654ffde0e012851098c52eeb65c81b8214700f47ff55888612ca4623fefbaf8bfab2a62f83c6367df9714ccff41d85d1ba43a150", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/706c00931fb1bce20feedb7180fb62817efef4fd879f10093cab7289d4084c00dcd37dfad3c14195aa8f76e7e29af9f2883a9e4adc45c18fb3965e95316a187e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/191b884e0ad5152d0bdbd5bd1506289403db3249dbdf4fd58371f62a8d0930e7d7b13df59f5c0852f84a17f9b530971c8a192c7b97d7fa450c8e678fdb727866"} build_url:https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011295 build_url: 'https://queue.taskcluster.net/v1/task/JkCo8rXlRemHvB9foFDoPw/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e0ed316b3ca179b4a5207884e09eb12a3f046201b777e55c4ba9cf83525adb60d7416ca4afe687b30dd41ec3aa5b9e557b3bf03953a9b68b2882d5378970d5f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bde39d34b6f6b8eb504e36ba654ffde0e012851098c52eeb65c81b8214700f47ff55888612ca4623fefbaf8bfab2a62f83c6367df9714ccff41d85d1ba43a150", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/706c00931fb1bce20feedb7180fb62817efef4fd879f10093cab7289d4084c00dcd37dfad3c14195aa8f76e7e29af9f2883a9e4adc45c18fb3965e95316a187e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/191b884e0ad5152d0bdbd5bd1506289403db3249dbdf4fd58371f62a8d0930e7d7b13df59f5c0852f84a17f9b530971c8a192c7b97d7fa450c8e678fdb727866"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-03 05:25:19.625962) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 05:25:19.626393) ========= 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=97facb8ba2ac28944cc45e6b000001d4-1486127070.674924-279435095 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004381 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-03 05:25:19.711947) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 05:25:19.712352) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-03 05:25:19.712826) ========= ========= Total master_lag: 0.15 =========