builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-001 starttime: 1483807986.73 results: success (0) revision: 2d62b03b833b7e142c530dbcaf4424e357769170 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-07 08:53:06.732956) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-07 08:53:06.733427) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-07 08:53:06.733819) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-07 08:53:06.749178) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 08:53:06.749498) ========= 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=8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-07 08:53:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2017-01-07 08:53:07 (222 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.134996 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 08:53:06.907081) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 08:53:06.907414) ========= 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=8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019452 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 08:53:06.957698) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 08:53:06.958118) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 2d62b03b833b7e142c530dbcaf4424e357769170 --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 2d62b03b833b7e142c530dbcaf4424e357769170 --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=8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-07 08:53:07,533 truncating revision to first 12 chars 2017-01-07 08:53:07,534 Setting DEBUG logging. 2017-01-07 08:53:07,534 attempt 1/10 2017-01-07 08:53:07,534 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/2d62b03b833b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-07 08:53:07,855 unpacking tar archive at: mozilla-central-2d62b03b833b/testing/mozharness/ program finished with exit code 0 elapsedTime=0.612098 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 08:53:07.584299) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-07 08:53:07.584692) ========= script_repo_revision: 2d62b03b833b7e142c530dbcaf4424e357769170 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-07 08:53:07.585147) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-07 08:53:07.585459) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-07 08:53:07.596583) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-01-07 08:53:07.597042) ========= /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=8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:53:08 INFO - MultiFileLogger online at 20170107 08:53:08 in /builds/slave/test 08:53:08 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 08:53:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:53:08 INFO - {'append_to_log': False, 08:53:08 INFO - 'base_work_dir': '/builds/slave/test', 08:53:08 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 08:53:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:53:08 INFO - 'branch': 'Firefox-Non-PGO', 08:53:08 INFO - 'buildbot_json_path': 'buildprops.json', 08:53:08 INFO - 'config_files': ('talos/linux_config.py',), 08:53:08 INFO - 'default_actions': ('clobber', 08:53:08 INFO - 'read-buildbot-config', 08:53:08 INFO - 'download-and-extract', 08:53:08 INFO - 'populate-webroot', 08:53:08 INFO - 'create-virtualenv', 08:53:08 INFO - 'install', 08:53:08 INFO - 'run-tests'), 08:53:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:53:08 INFO - 'download_minidump_stackwalk': True, 08:53:08 INFO - 'download_symbols': 'ondemand', 08:53:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:53:08 INFO - 'tooltool.py': '/tools/tooltool.py', 08:53:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:53:08 INFO - '/tools/misc-python/virtualenv.py')}, 08:53:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:53:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:53:08 INFO - 'installer_path': 'installer.exe', 08:53:08 INFO - 'log_level': 'info', 08:53:08 INFO - 'log_name': 'talos', 08:53:08 INFO - 'log_to_console': True, 08:53:08 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:53:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:53:08 INFO - 'opt_config_files': (), 08:53:08 INFO - 'pip_index': False, 08:53:08 INFO - 'sps_profile': False, 08:53:08 INFO - 'sps_profile_interval': 0, 08:53:08 INFO - 'suite': 'dromaeojs-e10s', 08:53:08 INFO - 'system_bits': '32', 08:53:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:53:08 INFO - 'title': 'talos-linux64-ix-001', 08:53:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:53:08 INFO - 'use_talos_json': True, 08:53:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:53:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:53:08 INFO - 'work_dir': 'build'} 08:53:08 INFO - [mozharness: 2017-01-07 16:53:08.270138Z] Running clobber step. 08:53:08 INFO - Running pre-action listener: _resource_record_pre_action 08:53:08 INFO - Running main action method: clobber 08:53:08 INFO - rmtree: /builds/slave/test/build 08:53:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:53:08 INFO - Running post-action listener: _resource_record_post_action 08:53:08 INFO - [mozharness: 2017-01-07 16:53:08.728413Z] Finished clobber step (success) 08:53:08 INFO - [mozharness: 2017-01-07 16:53:08.728512Z] Running read-buildbot-config step. 08:53:08 INFO - Running pre-action listener: _resource_record_pre_action 08:53:08 INFO - Running main action method: read_buildbot_config 08:53:08 INFO - Using buildbot properties: 08:53:08 INFO - { 08:53:08 INFO - "project": "", 08:53:08 INFO - "product": "firefox", 08:53:08 INFO - "who": "ryanvm@gmail.com", 08:53:08 INFO - "installer_path": "public/build/target.tar.bz2", 08:53:08 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 08:53:08 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 08:53:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 08:53:08 INFO - "stage_platform": "linux64", 08:53:08 INFO - "basedir": "/builds/slave/test", 08:53:08 INFO - "buildnumber": 630, 08:53:08 INFO - "platform": "ubuntu64_hw", 08:53:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:53:08 INFO - "slavebuilddir": "test", 08:53:08 INFO - "taskId": "cjWazi5CStqY134iZ4281A", 08:53:08 INFO - "branch": "mozilla-central", 08:53:08 INFO - "script_repo_revision": "production", 08:53:08 INFO - "revision": "2d62b03b833b7e142c530dbcaf4424e357769170", 08:53:08 INFO - "slavename": "talos-linux64-ix-001", 08:53:08 INFO - "repo_path": "mozilla-central" 08:53:08 INFO - } 08:53:08 INFO - Finding installer, test and symbols from parent task. 08:53:08 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cjWazi5CStqY134iZ4281A'}, attempt #1 08:53:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cjWazi5CStqY134iZ4281A'}, attempt #1 08:53:09 INFO - Task dependencies: FAfCRL6cTjaWvpEhSzvceQ 08:53:09 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FAfCRL6cTjaWvpEhSzvceQ'}, attempt #1 08:53:10 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/FAfCRL6cTjaWvpEhSzvceQ/artifacts/public/build/target.tar.bz2 08:53:10 INFO - Set test_url: https://queue.taskcluster.net/v1/task/FAfCRL6cTjaWvpEhSzvceQ/artifacts/public/build/test_packages.json 08:53:10 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/FAfCRL6cTjaWvpEhSzvceQ/artifacts/public/build/target.crashreporter-symbols.zip 08:53:10 INFO - Running post-action listener: _resource_record_post_action 08:53:10 INFO - [mozharness: 2017-01-07 16:53:10.198796Z] Finished read-buildbot-config step (success) 08:53:10 INFO - [mozharness: 2017-01-07 16:53:10.199011Z] Running download-and-extract step. 08:53:10 INFO - Running pre-action listener: _resource_record_pre_action 08:53:10 INFO - Running main action method: download_and_extract 08:53:10 INFO - mkdir: /builds/slave/test/build/tests 08:53: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')]} 08:53:10 INFO - trying https://queue.taskcluster.net/v1/task/FAfCRL6cTjaWvpEhSzvceQ/artifacts/public/build/target.test_packages.json 08:53:10 INFO - Downloading https://queue.taskcluster.net/v1/task/FAfCRL6cTjaWvpEhSzvceQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 08:53:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FAfCRL6cTjaWvpEhSzvceQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 08:53:10 INFO - Downloaded 896 bytes. 08:53:10 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 08:53:10 INFO - Using the following test package requirements: 08:53:10 INFO - {u'common': [u'target.common.tests.zip'], 08:53:10 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 08:53:10 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 08:53:10 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 08:53:10 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 08:53:10 INFO - u'mozbase': [u'target.common.tests.zip'], 08:53:10 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 08:53:10 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 08:53:10 INFO - u'web-platform': [u'target.common.tests.zip', 08:53:10 INFO - u'target.web-platform.tests.zip'], 08:53:10 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 08:53:10 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 08:53:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FAfCRL6cTjaWvpEhSzvceQ/artifacts/public/build/target.common.tests.zip 08:53:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FAfCRL6cTjaWvpEhSzvceQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:53:10 INFO - Fetch https://queue.taskcluster.net/v1/task/FAfCRL6cTjaWvpEhSzvceQ/artifacts/public/build/target.common.tests.zip into memory 08:53:11 INFO - Expected file size: 20248112 08:53:11 INFO - Obtained file size: 20248112 08:53:15 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 08:53:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FAfCRL6cTjaWvpEhSzvceQ/artifacts/public/build/target.common.tests.zip 08:53:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FAfCRL6cTjaWvpEhSzvceQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 08:53:15 INFO - Fetch https://queue.taskcluster.net/v1/task/FAfCRL6cTjaWvpEhSzvceQ/artifacts/public/build/target.common.tests.zip into memory 08:53:16 INFO - Expected file size: 20248112 08:53:16 INFO - Obtained file size: 20248112 08:53:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FAfCRL6cTjaWvpEhSzvceQ/artifacts/public/build/target.talos.tests.zip 08:53:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FAfCRL6cTjaWvpEhSzvceQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 08:53:20 INFO - Fetch https://queue.taskcluster.net/v1/task/FAfCRL6cTjaWvpEhSzvceQ/artifacts/public/build/target.talos.tests.zip into memory 08:53:21 INFO - Expected file size: 14403537 08:53:21 INFO - Obtained file size: 14403537 08:53:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:21 INFO - trying https://queue.taskcluster.net/v1/task/FAfCRL6cTjaWvpEhSzvceQ/artifacts/public/build/target.tar.bz2 08:53:21 INFO - Downloading https://queue.taskcluster.net/v1/task/FAfCRL6cTjaWvpEhSzvceQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 08:53:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FAfCRL6cTjaWvpEhSzvceQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 08:53:22 INFO - Downloaded 55885864 bytes. 08:53:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FAfCRL6cTjaWvpEhSzvceQ/artifacts/public/build/target.tar.bz2 08:53:22 INFO - mkdir: /builds/slave/test/properties 08:53:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:53:22 INFO - Writing to file /builds/slave/test/properties/build_url 08:53:22 INFO - Contents: 08:53:22 INFO - build_url:https://queue.taskcluster.net/v1/task/FAfCRL6cTjaWvpEhSzvceQ/artifacts/public/build/target.tar.bz2 08:53:22 INFO - Running post-action listener: _resource_record_post_action 08:53:22 INFO - Running post-action listener: set_extra_try_arguments 08:53:22 INFO - [mozharness: 2017-01-07 16:53:22.875262Z] Finished download-and-extract step (success) 08:53:22 INFO - [mozharness: 2017-01-07 16:53:22.875358Z] Running populate-webroot step. 08:53:22 INFO - Running pre-action listener: _resource_record_pre_action 08:53:22 INFO - Running main action method: populate_webroot 08:53:22 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:53:22 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:53:22 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:53:22 INFO - '--tppagecycles', 08:53:22 INFO - '7'], 08:53:22 INFO - 'tests': ['tsvgm']}}, 08:53:22 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:53:22 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:53:22 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:53:22 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:53:22 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:53:22 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:53:22 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:53:22 INFO - 'talos_options': ['--disable-e10s'], 08:53:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:22 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:53:22 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:53:22 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:53:22 INFO - 'talos_options': ['--disable-e10s'], 08:53:22 INFO - 'tests': ['damp', 'tps']}, 08:53:22 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:53:22 INFO - 'tests': ['damp', 'tps']}, 08:53:22 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:53:22 INFO - 'tests': ['dromaeo_dom']}, 08:53:22 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:53:22 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:53:22 INFO - 'tests': ['basic_compositor_video']}, 08:53:22 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:53:22 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:53:22 INFO - 'tests': ['a11yr', 08:53:22 INFO - 'ts_paint', 08:53:22 INFO - 'tpaint', 08:53:22 INFO - 'sessionrestore', 08:53:22 INFO - 'sessionrestore_no_auto_restore', 08:53:22 INFO - 'tabpaint']}, 08:53:22 INFO - 'other-e10s': {'tests': ['a11yr', 08:53:22 INFO - 'ts_paint', 08:53:22 INFO - 'tpaint', 08:53:22 INFO - 'sessionrestore', 08:53:22 INFO - 'sessionrestore_no_auto_restore', 08:53:22 INFO - 'tabpaint']}, 08:53:22 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:53:22 INFO - 'ts_paint', 08:53:22 INFO - 'tpaint', 08:53:22 INFO - 'sessionrestore', 08:53:22 INFO - 'sessionrestore_no_auto_restore', 08:53:22 INFO - 'tabpaint']}, 08:53:22 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:53:22 INFO - 'ts_paint', 08:53:22 INFO - 'tpaint', 08:53:22 INFO - 'sessionrestore', 08:53:22 INFO - 'sessionrestore_no_auto_restore', 08:53:22 INFO - 'tabpaint']}, 08:53:22 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:53:22 INFO - 'tests': ['a11yr', 08:53:22 INFO - 'ts_paint', 08:53:22 INFO - 'tpaint', 08:53:22 INFO - 'sessionrestore', 08:53:22 INFO - 'sessionrestore_no_auto_restore', 08:53:22 INFO - 'tabpaint']}, 08:53:22 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:53:22 INFO - 'tests': ['a11yr', 08:53:22 INFO - 'ts_paint', 08:53:22 INFO - 'tpaint', 08:53:22 INFO - 'sessionrestore', 08:53:22 INFO - 'sessionrestore_no_auto_restore', 08:53:22 INFO - 'tabpaint']}, 08:53:22 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:53:22 INFO - 'tests': ['tsvgx', 08:53:22 INFO - 'tsvgr_opacity', 08:53:22 INFO - 'tart', 08:53:22 INFO - 'tscrollx', 08:53:22 INFO - 'cart', 08:53:22 INFO - 'tsvg_static']}, 08:53:22 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:53:22 INFO - 'tsvgr_opacity', 08:53:22 INFO - 'tart', 08:53:22 INFO - 'tscrollx', 08:53:22 INFO - 'cart', 08:53:22 INFO - 'tsvg_static']}, 08:53:22 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:53:22 INFO - 'talos_options': ['--disable-e10s'], 08:53:22 INFO - 'tests': ['tp5o']}, 08:53:22 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:53:22 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:53:22 INFO - 'talos_options': ['--disable-e10s', 08:53:22 INFO - '--xperf_path', 08:53:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:22 INFO - 'tests': ['tp5n']}, 08:53:22 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:53:22 INFO - 'talos_options': ['--xperf_path', 08:53:22 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:53:22 INFO - 'tests': ['tp5n']}}, 08:53:22 INFO - 'talos.zip': {'path': '', 08:53:22 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:53:22 INFO - Running post-action listener: _resource_record_post_action 08:53:22 INFO - [mozharness: 2017-01-07 16:53:22.888403Z] Finished populate-webroot step (success) 08:53:22 INFO - [mozharness: 2017-01-07 16:53:22.888492Z] Running create-virtualenv step. 08:53:22 INFO - Running pre-action listener: _resource_record_pre_action 08:53:22 INFO - Running main action method: create_virtualenv 08:53:22 INFO - Creating virtualenv /builds/slave/test/build/venv 08:53:22 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 08:53:22 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:53:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:53:22 INFO - Using real prefix '/usr' 08:53:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:53:23 INFO - Installing distribute.............................................................................................................................................................................................done. 08:53:25 INFO - Installing pip.................done. 08:53:25 INFO - Return code: 0 08:53:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:53:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:53:25 INFO - Reading from file tmpfile_stdout 08:53:25 INFO - Output received: 08:53:25 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) 08:53:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:53:25 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')]} 08:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:25 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')]} 08:53:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:25 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 0x20261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2398480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2395820>, '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 0x2396520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23969b0>, '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': '8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628', '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 08:53:25 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 08:53:25 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 08:53:25 INFO - Using env: {'DISPLAY': ':0', 08:53:25 INFO - 'HOME': '/home/cltbld', 08:53:25 INFO - 'LANG': 'en_US.UTF-8', 08:53:25 INFO - 'LANGUAGE': 'en_US:en', 08:53:25 INFO - 'LOGNAME': 'cltbld', 08:53:25 INFO - 'MAIL': '/var/mail/cltbld', 08:53:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:25 INFO - 'MOZ_NO_REMOTE': '1', 08:53:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:25 INFO - 'NO_EM_RESTART': '1', 08:53:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:25 INFO - 'PWD': '/builds/slave/test', 08:53:25 INFO - 'SHELL': '/bin/bash', 08:53:25 INFO - 'SHLVL': '1', 08:53:25 INFO - 'TERM': 'linux', 08:53:25 INFO - 'TMOUT': '86400', 08:53:25 INFO - 'USER': 'cltbld', 08:53:25 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628', 08:53:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:25 INFO - '_': '/tools/buildbot/bin/python'} 08:53:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:25 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 08:53:25 INFO - Cleaning up... 08:53:25 INFO - Return code: 0 08:53:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:53:25 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')]} 08:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:25 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')]} 08:53:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:25 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 0x20261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2398480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2395820>, '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 0x2396520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23969b0>, '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': '8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628', '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 08:53:25 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 08:53:25 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 08:53:25 INFO - Using env: {'DISPLAY': ':0', 08:53:25 INFO - 'HOME': '/home/cltbld', 08:53:25 INFO - 'LANG': 'en_US.UTF-8', 08:53:25 INFO - 'LANGUAGE': 'en_US:en', 08:53:25 INFO - 'LOGNAME': 'cltbld', 08:53:25 INFO - 'MAIL': '/var/mail/cltbld', 08:53:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:25 INFO - 'MOZ_NO_REMOTE': '1', 08:53:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:25 INFO - 'NO_EM_RESTART': '1', 08:53:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:25 INFO - 'PWD': '/builds/slave/test', 08:53:25 INFO - 'SHELL': '/bin/bash', 08:53:25 INFO - 'SHLVL': '1', 08:53:25 INFO - 'TERM': 'linux', 08:53:25 INFO - 'TMOUT': '86400', 08:53:25 INFO - 'USER': 'cltbld', 08:53:25 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628', 08:53:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:25 INFO - '_': '/tools/buildbot/bin/python'} 08:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:26 INFO - Downloading/unpacking psutil>=3.1.1 08:53:26 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 08:53:26 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 08:53:26 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 08:53:26 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 08:53:26 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 08:53:26 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 08:53:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:53:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:28 INFO - Installing collected packages: psutil 08:53:28 INFO - Running setup.py install for psutil 08:53:28 INFO - building 'psutil._psutil_linux' extension 08:53:28 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 08:53:28 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 08:53:28 INFO - building 'psutil._psutil_posix' extension 08:53:28 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 08:53:28 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 08:53:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:53:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:53:28 INFO - Successfully installed psutil 08:53:28 INFO - Cleaning up... 08:53:28 INFO - Return code: 0 08:53:28 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:53:28 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')]} 08:53:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:28 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')]} 08:53:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:28 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 0x20261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2398480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2395820>, '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 0x2396520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23969b0>, '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': '8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628', '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 08:53:28 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 08:53:28 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 08:53:28 INFO - Using env: {'DISPLAY': ':0', 08:53:28 INFO - 'HOME': '/home/cltbld', 08:53:28 INFO - 'LANG': 'en_US.UTF-8', 08:53:28 INFO - 'LANGUAGE': 'en_US:en', 08:53:28 INFO - 'LOGNAME': 'cltbld', 08:53:28 INFO - 'MAIL': '/var/mail/cltbld', 08:53:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:28 INFO - 'MOZ_NO_REMOTE': '1', 08:53:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:28 INFO - 'NO_EM_RESTART': '1', 08:53:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:28 INFO - 'PWD': '/builds/slave/test', 08:53:28 INFO - 'SHELL': '/bin/bash', 08:53:28 INFO - 'SHLVL': '1', 08:53:28 INFO - 'TERM': 'linux', 08:53:28 INFO - 'TMOUT': '86400', 08:53:28 INFO - 'USER': 'cltbld', 08:53:28 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628', 08:53:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:28 INFO - '_': '/tools/buildbot/bin/python'} 08:53:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:53:28 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 08:53:28 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 08:53:28 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 08:53:28 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 08:53:28 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 08:53:28 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 08:53:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:53:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:53:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:53:31 INFO - Installing collected packages: mozsystemmonitor 08:53:31 INFO - Running setup.py install for mozsystemmonitor 08:53:31 INFO - Successfully installed mozsystemmonitor 08:53:31 INFO - Cleaning up... 08:53:31 INFO - Return code: 0 08:53:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2398480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2395820>, '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 0x2396520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23969b0>, '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': '8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628', '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 08:53:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:53:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:53:31 INFO - Using env: {'DISPLAY': ':0', 08:53:31 INFO - 'HOME': '/home/cltbld', 08:53:31 INFO - 'LANG': 'en_US.UTF-8', 08:53:31 INFO - 'LANGUAGE': 'en_US:en', 08:53:31 INFO - 'LOGNAME': 'cltbld', 08:53:31 INFO - 'MAIL': '/var/mail/cltbld', 08:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:31 INFO - 'MOZ_NO_REMOTE': '1', 08:53:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:31 INFO - 'NO_EM_RESTART': '1', 08:53:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:31 INFO - 'PWD': '/builds/slave/test', 08:53:31 INFO - 'SHELL': '/bin/bash', 08:53:31 INFO - 'SHLVL': '1', 08:53:31 INFO - 'TERM': 'linux', 08:53:31 INFO - 'TMOUT': '86400', 08:53:31 INFO - 'USER': 'cltbld', 08:53:31 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628', 08:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:31 INFO - '_': '/tools/buildbot/bin/python'} 08:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:31 INFO - Downloading/unpacking jsonschema==2.5.1 08:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:53:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:33 INFO - Downloading functools32-3.2.3-2.tar.gz 08:53:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:53:33 INFO - warning: no files found matching '*.txt' 08:53:33 INFO - no previously-included directories found matching 'build' 08:53:33 INFO - no previously-included directories found matching 'dist' 08:53:33 INFO - no previously-included directories found matching '.git*' 08:53:33 INFO - Installing collected packages: jsonschema, functools32 08:53:33 INFO - Running setup.py install for functools32 08:53:33 INFO - warning: no files found matching '*.txt' 08:53:33 INFO - no previously-included directories found matching 'build' 08:53:33 INFO - no previously-included directories found matching 'dist' 08:53:33 INFO - no previously-included directories found matching '.git*' 08:53:33 INFO - Successfully installed jsonschema functools32 08:53:33 INFO - Cleaning up... 08:53:33 INFO - Return code: 0 08:53:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:53:33 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')]} 08:53:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:33 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')]} 08:53:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:33 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 0x20261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2398480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2395820>, '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 0x2396520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23969b0>, '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': '8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628', '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 08:53:33 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 08:53:33 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 08:53:33 INFO - Using env: {'DISPLAY': ':0', 08:53:33 INFO - 'HOME': '/home/cltbld', 08:53:33 INFO - 'LANG': 'en_US.UTF-8', 08:53:33 INFO - 'LANGUAGE': 'en_US:en', 08:53:33 INFO - 'LOGNAME': 'cltbld', 08:53:33 INFO - 'MAIL': '/var/mail/cltbld', 08:53:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:33 INFO - 'MOZ_NO_REMOTE': '1', 08:53:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:33 INFO - 'NO_EM_RESTART': '1', 08:53:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:33 INFO - 'PWD': '/builds/slave/test', 08:53:33 INFO - 'SHELL': '/bin/bash', 08:53:33 INFO - 'SHLVL': '1', 08:53:33 INFO - 'TERM': 'linux', 08:53:33 INFO - 'TMOUT': '86400', 08:53:33 INFO - 'USER': 'cltbld', 08:53:33 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628', 08:53:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:33 INFO - '_': '/tools/buildbot/bin/python'} 08:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:53:34 INFO - Cleaning up... 08:53:34 INFO - Return code: 0 08:53:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:53: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')]} 08:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53: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')]} 08:53:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x20261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2398480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2395820>, '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 0x2396520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23969b0>, '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': '8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628', '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 08:53:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:53:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:53:34 INFO - Using env: {'DISPLAY': ':0', 08:53:34 INFO - 'HOME': '/home/cltbld', 08:53:34 INFO - 'LANG': 'en_US.UTF-8', 08:53:34 INFO - 'LANGUAGE': 'en_US:en', 08:53:34 INFO - 'LOGNAME': 'cltbld', 08:53:34 INFO - 'MAIL': '/var/mail/cltbld', 08:53:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:34 INFO - 'MOZ_NO_REMOTE': '1', 08:53:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:34 INFO - 'NO_EM_RESTART': '1', 08:53:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:34 INFO - 'PWD': '/builds/slave/test', 08:53:34 INFO - 'SHELL': '/bin/bash', 08:53:34 INFO - 'SHLVL': '1', 08:53:34 INFO - 'TERM': 'linux', 08:53:34 INFO - 'TMOUT': '86400', 08:53:34 INFO - 'USER': 'cltbld', 08:53:34 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628', 08:53:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:34 INFO - '_': '/tools/buildbot/bin/python'} 08:53:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:34 INFO - Downloading/unpacking blobuploader==1.2.4 08:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:36 INFO - Downloading blobuploader-1.2.4.tar.gz 08:53:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:53:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:53:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:37 INFO - Downloading docopt-0.6.1.tar.gz 08:53:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:53:37 INFO - Installing collected packages: blobuploader, requests, docopt 08:53:37 INFO - Running setup.py install for blobuploader 08:53:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:53:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:53:37 INFO - Running setup.py install for requests 08:53:37 INFO - Running setup.py install for docopt 08:53:37 INFO - Successfully installed blobuploader requests docopt 08:53:37 INFO - Cleaning up... 08:53:37 INFO - Return code: 0 08:53:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:37 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 0x20261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2398480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2395820>, '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 0x2396520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23969b0>, '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': '8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628', '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 08:53:37 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 08:53:37 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 08:53:37 INFO - Using env: {'DISPLAY': ':0', 08:53:37 INFO - 'HOME': '/home/cltbld', 08:53:37 INFO - 'LANG': 'en_US.UTF-8', 08:53:37 INFO - 'LANGUAGE': 'en_US:en', 08:53:37 INFO - 'LOGNAME': 'cltbld', 08:53:37 INFO - 'MAIL': '/var/mail/cltbld', 08:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:37 INFO - 'MOZ_NO_REMOTE': '1', 08:53:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:37 INFO - 'NO_EM_RESTART': '1', 08:53:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:37 INFO - 'PWD': '/builds/slave/test', 08:53:37 INFO - 'SHELL': '/bin/bash', 08:53:37 INFO - 'SHLVL': '1', 08:53:37 INFO - 'TERM': 'linux', 08:53:37 INFO - 'TMOUT': '86400', 08:53:37 INFO - 'USER': 'cltbld', 08:53:37 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628', 08:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:37 INFO - '_': '/tools/buildbot/bin/python'} 08:53:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:37 INFO - Running setup.py (path:/tmp/pip-OFRMq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:38 INFO - Running setup.py (path:/tmp/pip-5QIRzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:38 INFO - Running setup.py (path:/tmp/pip-U5CpCt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:38 INFO - Running setup.py (path:/tmp/pip-Fx2jAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:38 INFO - Running setup.py (path:/tmp/pip-bKI5G_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:38 INFO - Running setup.py (path:/tmp/pip-TsYpX9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:38 INFO - Running setup.py (path:/tmp/pip-s5AmTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:38 INFO - Running setup.py (path:/tmp/pip-1WqX2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:38 INFO - Running setup.py (path:/tmp/pip-H_ydUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:38 INFO - Running setup.py (path:/tmp/pip-IfcBHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:38 INFO - Running setup.py (path:/tmp/pip-cjmXH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:38 INFO - Running setup.py (path:/tmp/pip-qKmxGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:38 INFO - Running setup.py (path:/tmp/pip-JAhsCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:38 INFO - Running setup.py (path:/tmp/pip-mJUZAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:38 INFO - Running setup.py (path:/tmp/pip-2S2NaL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:39 INFO - Running setup.py (path:/tmp/pip-AMuEN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:39 INFO - Running setup.py (path:/tmp/pip-ZY7cU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:53:39 INFO - Running setup.py install for manifestparser 08:53:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:53:39 INFO - Running setup.py install for mozcrash 08:53:39 INFO - Running setup.py install for mozdebug 08:53:39 INFO - Running setup.py install for mozdevice 08:53:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:53:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:53:39 INFO - Running setup.py install for mozfile 08:53:39 INFO - Running setup.py install for mozhttpd 08:53:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:53:39 INFO - Running setup.py install for mozinfo 08:53:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:53:39 INFO - Running setup.py install for mozInstall 08:53:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:53:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:53:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:53:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:53:39 INFO - Running setup.py install for mozleak 08:53:40 INFO - Running setup.py install for mozlog 08:53:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:53:40 INFO - Running setup.py install for moznetwork 08:53:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:53:40 INFO - Running setup.py install for mozprocess 08:53:40 INFO - Running setup.py install for mozprofile 08:53:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:53:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:53:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:53:40 INFO - Running setup.py install for mozrunner 08:53:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:53:40 INFO - Running setup.py install for mozscreenshot 08:53:40 INFO - Running setup.py install for moztest 08:53:40 INFO - Running setup.py install for mozversion 08:53:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:53:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:53:40 INFO - Cleaning up... 08:53:40 INFO - Return code: 0 08:53:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:40 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')]} 08:53:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:40 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')]} 08:53:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:40 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 0x20261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2398480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2395820>, '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 0x2396520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23969b0>, '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': '8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628', '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 08:53:40 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 08:53:40 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 08:53:40 INFO - Using env: {'DISPLAY': ':0', 08:53:40 INFO - 'HOME': '/home/cltbld', 08:53:40 INFO - 'LANG': 'en_US.UTF-8', 08:53:40 INFO - 'LANGUAGE': 'en_US:en', 08:53:40 INFO - 'LOGNAME': 'cltbld', 08:53:40 INFO - 'MAIL': '/var/mail/cltbld', 08:53:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:40 INFO - 'MOZ_NO_REMOTE': '1', 08:53:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:40 INFO - 'NO_EM_RESTART': '1', 08:53:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:40 INFO - 'PWD': '/builds/slave/test', 08:53:40 INFO - 'SHELL': '/bin/bash', 08:53:40 INFO - 'SHLVL': '1', 08:53:40 INFO - 'TERM': 'linux', 08:53:40 INFO - 'TMOUT': '86400', 08:53:40 INFO - 'USER': 'cltbld', 08:53:40 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628', 08:53:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:40 INFO - '_': '/tools/buildbot/bin/python'} 08:53:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:53:41 INFO - Running setup.py (path:/tmp/pip-g8oq_k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:53:41 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)) 08:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:53:41 INFO - Running setup.py (path:/tmp/pip-0P13Ib-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:53:41 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)) 08:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:53:41 INFO - Running setup.py (path:/tmp/pip-xu1McZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:53:41 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)) 08:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:53:41 INFO - Running setup.py (path:/tmp/pip-KKQupc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:53:41 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)) 08:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:53:41 INFO - Running setup.py (path:/tmp/pip-ueOAkb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:53:41 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)) 08:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:53:41 INFO - Running setup.py (path:/tmp/pip-JsNUth-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:53:41 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)) 08:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:53:41 INFO - Running setup.py (path:/tmp/pip-Zrow2E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:53:41 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)) 08:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:53:41 INFO - Running setup.py (path:/tmp/pip-a2gNFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:53:41 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)) 08:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:53:41 INFO - Running setup.py (path:/tmp/pip-gQcrAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:53:41 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)) 08:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:53:41 INFO - Running setup.py (path:/tmp/pip-TpbXQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:53:41 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)) 08:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:53:41 INFO - Running setup.py (path:/tmp/pip-VFuqmS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:53:41 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)) 08:53:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:53:41 INFO - Running setup.py (path:/tmp/pip-hcmhW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:53:42 INFO - Running setup.py (path:/tmp/pip-kiMThK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:53:42 INFO - Running setup.py (path:/tmp/pip-CFVeW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:42 INFO - Running setup.py (path:/tmp/pip-B0nwy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:53:42 INFO - Running setup.py (path:/tmp/pip-Gmsoki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:53:42 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)) 08:53:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:53:42 INFO - Running setup.py (path:/tmp/pip-yUqLMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:53:42 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)) 08:53:42 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)) 08:53:42 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)) 08:53:42 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)) 08:53:42 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)) 08:53:42 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)) 08:53:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:53:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:53:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:53:44 INFO - Downloading blessings-1.6.tar.gz 08:53:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:53:44 INFO - Installing collected packages: blessings 08:53:44 INFO - Running setup.py install for blessings 08:53:44 INFO - Successfully installed blessings 08:53:44 INFO - Cleaning up... 08:53:44 INFO - Return code: 0 08:53:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:53:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:44 INFO - Reading from file tmpfile_stdout 08:53:44 INFO - Current package versions: 08:53:44 INFO - argparse == 1.2.1 08:53:44 INFO - blessings == 1.6 08:53:44 INFO - blobuploader == 1.2.4 08:53:44 INFO - docopt == 0.6.1 08:53:44 INFO - functools32 == 3.2.3-2 08:53:44 INFO - jsonschema == 2.5.1 08:53:44 INFO - manifestparser == 1.1 08:53:44 INFO - mozInstall == 1.12 08:53:44 INFO - mozcrash == 1.0 08:53:44 INFO - mozdebug == 0.1 08:53:44 INFO - mozdevice == 0.49 08:53:44 INFO - mozfile == 1.2 08:53:44 INFO - mozhttpd == 0.7 08:53:44 INFO - mozinfo == 0.9 08:53:44 INFO - mozleak == 0.1 08:53:44 INFO - mozlog == 3.4 08:53:44 INFO - moznetwork == 0.27 08:53:44 INFO - mozprocess == 0.24 08:53:44 INFO - mozprofile == 0.28 08:53:44 INFO - mozrunner == 6.13 08:53:44 INFO - mozscreenshot == 0.1 08:53:44 INFO - mozsystemmonitor == 0.3 08:53:44 INFO - moztest == 0.8 08:53:44 INFO - mozversion == 1.4 08:53:44 INFO - psutil == 3.1.1 08:53:44 INFO - requests == 1.2.3 08:53:44 INFO - wsgiref == 0.1.2 08:53:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:44 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 0x20261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2398480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2395820>, '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 0x2396520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23969b0>, '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': '8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628', '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 08:53:44 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 08:53:44 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 08:53:44 INFO - Using env: {'DISPLAY': ':0', 08:53:44 INFO - 'HOME': '/home/cltbld', 08:53:44 INFO - 'LANG': 'en_US.UTF-8', 08:53:44 INFO - 'LANGUAGE': 'en_US:en', 08:53:44 INFO - 'LOGNAME': 'cltbld', 08:53:44 INFO - 'MAIL': '/var/mail/cltbld', 08:53:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:44 INFO - 'MOZ_NO_REMOTE': '1', 08:53:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:44 INFO - 'NO_EM_RESTART': '1', 08:53:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:44 INFO - 'PWD': '/builds/slave/test', 08:53:44 INFO - 'SHELL': '/bin/bash', 08:53:44 INFO - 'SHLVL': '1', 08:53:44 INFO - 'TERM': 'linux', 08:53:44 INFO - 'TMOUT': '86400', 08:53:44 INFO - 'USER': 'cltbld', 08:53:44 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628', 08:53:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:44 INFO - '_': '/tools/buildbot/bin/python'} 08:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:45 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)) 08:53:45 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)) 08:53:45 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)) 08:53:45 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)) 08:53:45 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)) 08:53:45 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)) 08:53:45 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)) 08:53:45 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)) 08:53:45 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)) 08:53:45 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)) 08:53:45 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)) 08:53:45 INFO - Cleaning up... 08:53:45 INFO - Return code: 0 08:53:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:53:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:53:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:53:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:53:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x20261f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2137a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2398480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2395820>, '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 0x2396520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23969b0>, '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': '8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628', '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 08:53:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:53:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:53:45 INFO - Using env: {'DISPLAY': ':0', 08:53:45 INFO - 'HOME': '/home/cltbld', 08:53:45 INFO - 'LANG': 'en_US.UTF-8', 08:53:45 INFO - 'LANGUAGE': 'en_US:en', 08:53:45 INFO - 'LOGNAME': 'cltbld', 08:53:45 INFO - 'MAIL': '/var/mail/cltbld', 08:53:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:53:45 INFO - 'MOZ_NO_REMOTE': '1', 08:53:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:53:45 INFO - 'NO_EM_RESTART': '1', 08:53:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:53:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:53:45 INFO - 'PWD': '/builds/slave/test', 08:53:45 INFO - 'SHELL': '/bin/bash', 08:53:45 INFO - 'SHLVL': '1', 08:53:45 INFO - 'TERM': 'linux', 08:53:45 INFO - 'TMOUT': '86400', 08:53:45 INFO - 'USER': 'cltbld', 08:53:45 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628', 08:53:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:53:45 INFO - '_': '/tools/buildbot/bin/python'} 08:53:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:53:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:53:45 INFO - Cleaning up... 08:53:45 INFO - Return code: 0 08:53:45 INFO - Running post-action listener: _resource_record_post_action 08:53:45 INFO - Running post-action listener: _start_resource_monitoring 08:53:45 INFO - Starting resource monitoring. 08:53:45 INFO - [mozharness: 2017-01-07 16:53:45.417076Z] Finished create-virtualenv step (success) 08:53:45 INFO - [mozharness: 2017-01-07 16:53:45.417587Z] Running install step. 08:53:45 INFO - Running pre-action listener: _resource_record_pre_action 08:53:45 INFO - Running main action method: install 08:53:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:53:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:53:45 INFO - Reading from file tmpfile_stdout 08:53:45 INFO - Detecting whether we're running mozinstall >=1.0... 08:53:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:53:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:53:45 INFO - Reading from file tmpfile_stdout 08:53:45 INFO - Output received: 08:53:45 INFO - Usage: mozinstall [options] installer 08:53:45 INFO - Options: 08:53:45 INFO - -h, --help show this help message and exit 08:53:45 INFO - -d DEST, --destination=DEST 08:53:45 INFO - Directory to install application into. [default: 08:53:45 INFO - "/builds/slave/test"] 08:53:45 INFO - --app=APP Application being installed. [default: firefox] 08:53:45 INFO - mkdir: /builds/slave/test/build/application 08:53:45 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'] 08:53:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 08:54:02 INFO - Reading from file tmpfile_stdout 08:54:02 INFO - Output received: 08:54:02 INFO - /builds/slave/test/build/application/firefox/firefox 08:54:02 INFO - Running post-action listener: _resource_record_post_action 08:54:02 INFO - [mozharness: 2017-01-07 16:54:02.274066Z] Finished install step (success) 08:54:02 INFO - [mozharness: 2017-01-07 16:54:02.274336Z] Running run-tests step. 08:54:02 INFO - Running pre-action listener: _resource_record_pre_action 08:54:02 INFO - Running main action method: run_tests 08:54:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:54:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:54:02 INFO - Python 2.7.3 08:54:02 INFO - Return code: 0 08:54:02 INFO - grabbing minidump binary from tooltool 08:54: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')]} 08:54:02 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 0x2395820>, '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 0x2396520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23969b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:54:02 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 08:54:02 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 08:54:02 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 08:54:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:54:02 INFO - Return code: 0 08:54:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:54:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:54:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:54:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:54:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:54:02 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/FAfCRL6cTjaWvpEhSzvceQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 08:54:02 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/FAfCRL6cTjaWvpEhSzvceQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-001 --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 08:54:02 INFO - Using env: {'DISPLAY': ':0', 08:54:02 INFO - 'HOME': '/home/cltbld', 08:54:02 INFO - 'LANG': 'en_US.UTF-8', 08:54:02 INFO - 'LANGUAGE': 'en_US:en', 08:54:02 INFO - 'LOGNAME': 'cltbld', 08:54:02 INFO - 'MAIL': '/var/mail/cltbld', 08:54:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:54:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:54:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:54:02 INFO - 'MOZ_NO_REMOTE': '1', 08:54:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:54:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:54:02 INFO - 'NO_EM_RESTART': '1', 08:54:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:54:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:54:02 INFO - 'PWD': '/builds/slave/test', 08:54:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:54:02 INFO - 'SHELL': '/bin/bash', 08:54:02 INFO - 'SHLVL': '1', 08:54:02 INFO - 'TERM': 'linux', 08:54:02 INFO - 'TMOUT': '86400', 08:54:02 INFO - 'USER': 'cltbld', 08:54:02 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628', 08:54:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:54:02 INFO - '_': '/tools/buildbot/bin/python'} 08:54:02 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/FAfCRL6cTjaWvpEhSzvceQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--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 08:54:02 INFO - mozversion application_buildid: 20170107162016 08:54:02 INFO - mozversion application_changeset: 2d62b03b833b7e142c530dbcaf4424e357769170 08:54:02 INFO - mozversion application_display_name: Nightly 08:54:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:54:02 INFO - mozversion application_name: Firefox 08:54:02 INFO - mozversion application_remotingname: firefox 08:54:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:54:02 INFO - mozversion application_vendor: Mozilla 08:54:02 INFO - mozversion application_version: 53.0a1 08:54:02 INFO - mozversion platform_buildid: 20170107162016 08:54:02 INFO - mozversion platform_changeset: 2d62b03b833b7e142c530dbcaf4424e357769170 08:54:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:54:02 INFO - mozversion platform_version: 53.0a1 08:54:02 INFO - using testdate: 1483808042 08:54:02 INFO - actual date: 1483808042 08:54:02 INFO - starting webserver on 'localhost:33839' 08:54:02 INFO - SUITE-START | Running 2 tests 08:54:02 INFO - TEST-START | dromaeo_css 08:54:02 INFO - operating with platform_type : linux_ 08:54:02 INFO - Initialising browser for dromaeo_css test... 08:54:02 INFO - TEST-INFO | started process 21658 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcCuU4U/profile http://localhost:33839/getInfo.html) 08:54:03 INFO - PROCESS | 21658 | 1483808043077 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 08:54:07 INFO - PROCESS | 21658 | __metrics Screen width/height:1600/1200 08:54:07 INFO - PROCESS | 21658 | colorDepth:24 08:54:07 INFO - PROCESS | 21658 | Browser inner width/height: 1024/697 08:54:07 INFO - PROCESS | 21658 | __metrics 08:54:07 ERROR - PROCESS | 21658 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 08:54:08 INFO - TEST-INFO | 21658: exit 0 08:54:08 INFO - Browser initialized. 08:54:08 INFO - Running cycle 1/1 for dromaeo_css test... 08:54:08 INFO - TEST-INFO | started process 21779 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcCuU4U/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:54:20 INFO - PROCESS | 21779 | RSS: Main: 159125504 08:54:20 INFO - PROCESS | 21779 | 08:57:24 INFO - PROCESS | 21779 | Cycle 1(1): loaded http://localhost:33839/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33839/tests/dromaeo/cssquery-ext.html) 08:57:25 INFO - PROCESS | 21779 | RSS: Main: 166400000 08:57:25 INFO - PROCESS | 21779 | 08:59:09 INFO - PROCESS | 21779 | ************************* 08:59:09 INFO - PROCESS | 21779 | A coding exception was thrown and uncaught in a Task. 08:59:09 INFO - PROCESS | 21779 | 08:59:09 INFO - PROCESS | 21779 | Full message: ReferenceError: fetch is not defined 08:59:09 INFO - PROCESS | 21779 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 08:59:09 INFO - PROCESS | 21779 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 08:59:09 INFO - PROCESS | 21779 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 08:59:09 INFO - PROCESS | 21779 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 08:59:09 INFO - PROCESS | 21779 | TaskImpl@resource://gre/modules/Task.jsm:277:3 08:59:09 INFO - PROCESS | 21779 | asyncFunction@resource://gre/modules/Task.jsm:252:14 08:59:09 INFO - PROCESS | 21779 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 08:59:09 INFO - PROCESS | 21779 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 08:59:09 INFO - PROCESS | 21779 | TaskImpl@resource://gre/modules/Task.jsm:277:3 08:59:09 INFO - PROCESS | 21779 | asyncFunction@resource://gre/modules/Task.jsm:252:14 08:59:09 INFO - PROCESS | 21779 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 08:59:09 INFO - PROCESS | 21779 | 08:59:09 INFO - PROCESS | 21779 | ************************* 09:00:28 INFO - PROCESS | 21779 | Cycle 1(1): loaded http://localhost:33839/tests/dromaeo/cssquery-ext.html (next: http://localhost:33839/tests/dromaeo/cssquery-jquery.html) 09:00:28 INFO - PROCESS | 21779 | RSS: Main: 162738176 09:00:28 INFO - PROCESS | 21779 | 09:03:31 INFO - PROCESS | 21779 | Cycle 1(1): loaded http://localhost:33839/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33839/tests/dromaeo/cssquery-mootools.html) 09:03:31 INFO - PROCESS | 21779 | RSS: Main: 168407040 09:03:31 INFO - PROCESS | 21779 | 09:06:33 INFO - PROCESS | 21779 | Cycle 1(1): loaded http://localhost:33839/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33839/tests/dromaeo/cssquery-prototype.html) 09:06:34 INFO - PROCESS | 21779 | RSS: Main: 163631104 09:06:34 INFO - PROCESS | 21779 | 09:09:37 INFO - PROCESS | 21779 | Cycle 1(1): loaded http://localhost:33839/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33839/tests/dromaeo/cssquery-yui.html) 09:09:38 INFO - PROCESS | 21779 | RSS: Main: 166162432 09:09:38 INFO - PROCESS | 21779 | 09:12:41 INFO - PROCESS | 21779 | Cycle 1(1): loaded http://localhost:33839/tests/dromaeo/cssquery-yui.html (next: http://localhost:33839/tests/dromaeo/cssquery-dojo.html) 09:12:41 INFO - PROCESS | 21779 | RSS: Main: 167411712 09:12:41 INFO - PROCESS | 21779 | 09:12:41 INFO - PROCESS | 21779 | __start_tp_report 09:12:41 INFO - PROCESS | 21779 | _x_x_mozilla_page_load 09:12:41 INFO - PROCESS | 21779 | _x_x_mozilla_page_load_details 09:12:41 INFO - PROCESS | 21779 | |i|pagename|runs| 09:12:41 INFO - PROCESS | 21779 | |0;dojo.html;2595.9480810383807;2597.9220623381298;2607.3611965068562;2625.0943424518546;2628.8817003234853;4647.907041859161;4690.718556886585;4725.763711814408;4737.73942433166;4748.976255118729;4667.976660116703;4684.882877928054;4735.3844000280005;4737.289406589013;4812.614990800736;4337.392765012893;4385.495667998173;4402.361657559652;4456.2647163218035;4486.753228572427;3988.601139886003;4422.491413487442;4427.1367083418745;4449.399331090293;4453.242948698729;4309.095090031097;4364.323529852878;4374.671899607542;4410.845620403286;4475.440569928759;4319;4330.545292744248;4340.65274778017;4361.520232774392;4363.36731173978;4310.245707001293;4328.696991210617;4331.592232524411;4343.913121737579;4373.059792144672;4567.634589232854;4652.278896771006;4668.393108895856;4669;4706.411698537683;4864.416270047617;4903.141950158708;5019.29729837823;5045.4197767256865;5057.848264552033;5084.593232541425;5104.846854594368;5108.5402313791565;5112.130937740593;5133.383993920754;4734.171519983989;4742.312364707098;4746.38297021385;4760.119377915097;4768.165571025092;5043.041822053798;5085.923711144262;5096.490350964874;5153.639245252796;5234.685918844882;4849.321095046696;4909.852704418873;4910.803567857246;4937.407511098691;4949.628777841676;5008.348914641147;5015.82444614444;5024.397072351268;5026.421961474477;5027.497250274943;4989.750512474435;4995.425526064477;4998.500149985045;5008.724520151354;5018.096742586369;4937.790241390882;4981.32752078472;4981.950180498221;4982.750862456863;4998.125328067574;4271.765052922119;4305.82776688929;4307.6769242306955;4314.374415709704;4318.265894797892;3689;3707.0361705956648;3740.102375429877;3782.791946442972;3789.9242015159543;4374.715643483163;4376.431063961664;4378.0806030733265;4385.934210986838;4431.955680443154;5000.4999500050435;5040.31955685985;5058.822941197041;5060.240963855451;5107.61692873036;4361.6074553290355;4396.296592545242;4397.6921615487245;4413.84551540701;4462.0183559616835;4515.412996310459;4581.129585378767;4589.839355622537;4598.448186217675;4642.628589712815;4704.435467743892;4797.496262892486;4801.855944321676;4803.663743537919;4839.733814640158;5034.194528875362;5034.270030845581;5062.392512898476;5064.696118232918;5178;4786.904261914812;4793.520647935178;4798.664093513421;4805.327254184487;4837.7581120944515;4972.577330926767;5008.148614735431;5020.548150666457;5026.346574945233;5064.670796398223;4953.455119936732;5002.52476014778;5026.748662566784;5047.848564543069;5074.010567939216;4927.408710954708;4933.457319694759;4935.309056731989;4939.97530012362;4968.925466118083;4818.566329030404;4857.732824694675;4863.3434486343895;4916.92624610624;4965.577925876197;4768.070226305976;4875.463698993179;4904.362432883845;4910.06708725341;4945.085159245551;4918.163912134874;4981.900361992813;4985.451600323889;5005.5745261653165;5023.723695196799;4841.12859685246;4853.757312134449;4858.149823780895;4879.292502587176;4901.803927842846 09:12:41 INFO - PROCESS | 21779 | |1;ext.html;517.3119750731527;531.7979167916192;532.6511135206441;537.4222710586121;554.664428021047;39664.80167599161;40969.3854592181;41041.589584104186;41154.794226028906;44817.32774008392;41064.58935410645;41327.58672413275;41417.58582414175;41502.16995660093;41561.16877662445;7697.884531732028;7858.803529911741;7863.292303692667;7870.763877083668;9453.243740500744;9565.713028609152;9742.853857192147;9750.171235444996;9750.804983900318;9756.317057805956;9794.118529332358;9852.064053914866;9855.457949812757;9873.654422095227;9881.258905582074;9661;9718.757031074245;9740.659076932274;9762.707118786448;9765.658201962897;9636.95181524095;9704.854427183598;9714.368566043184;9718.12536871685;9721.416714997053;34275;34441.138971525914;34492.82753586216;34512.65487345144;34605.480917786255;3567;3620.402633565485;3634.745567810254;3649.4708267301357;3676.6323367663285;25513;25938.22185334443;25938.481230375288;25942.870285648452;26312.47375052488;3468.0982944434377;3511.929761404783;3594.478800573902;3648.72634552407;3675.650813172744;232352;233085;233541;234028;235449;42960.78519607382;43161.568384316386;43328;47411.5258847414;47784.5221547787;48564.271535926986;48670.75664621654;48673.75663121662;48675.513244867805;48683;13335.733285334432;13744.862551374557;13764.862351376558;13838.716611759148;13913.23477208743;9470.857937130948;9675.419474831533;9719.708408747749;9816.558254878548;10636.787264254672;16219.27013284405;16228.432004879773;16387.42644007454;16437.26032328524;16467.752983705253;6391.360863913665;6425.58233714807;6454.612723236527;6462.547621666532;6778.559393639398;810.8621534339177;837.6076888601262;839.904950258288;843.4939036578004;863.6156910175038;27275.45449091007;28005.15984520468;28184.29539261535;28217;28478.715212847605;958.8801399825022;967.6274634265858;968.3560432312574;979.3438396274513;1041.578160844859;14386;14686.92656536732;14812.185329806964;15131.243437828065;15174.317155728018;350954;628382;638362;644040;644105;43754.34368484475;44260.77869610631;44290.557094429285;44303.335449968275;44410.22821006375;1202.9182638803018;1204.9096317776202;1236.4436003798507;1239.4794186441716;1242.2794779028143;25510.48979020372;26047;26514.602280965417;26779.196624101307;27011.054613088447;37709.622903770614;38083.428748568236;38119.42820857745;38468;38673.41989870098;347966;348816;349636;349792;350008;21645.13419463267;21717.457063573536;21726.34820955374;23387.53224935526;24061.51876962486;34625.307493849476;34863.30273394569;35700.107497312776;35740;35957;29793.553096703134;30024;30048.849755751082;30613.775448981793;31047.84476077605;29701.5544766833;29859.253518662208;30041;30445;30556.541651875683;29531.852340738158;29951.700482994893;30151.69848301489;30271.394572108875;30277.94027209037;22726.31821045371;24955.87522062378;25760.742392575834;26580;27969.72030279671;21431.838975297396;21461.570768584854;21645;21712.782872171076;21714.565708686056 09:12:41 INFO - PROCESS | 21779 | |2;jquery.html;375.66753423220456;384.2277023183402;386.7795356646711;401.3898873711956;403.3747691078827;17541.298348066077;18384.908075459636;18766.59250556207;18794.15426305816;18834.529136771587;17901.91049044756;17934;18124.36564720235;18324.083795810224;18365.7245141323;5136.512031357015;5193.1171700810955;5253.50091741284;5312.3093997780425;5348.598855085865;5108.540231379176;5265.078611243036;5271.998320319127;5276.683398996053;5276.788928442877;5245.527902488775;5246.239295302179;5247.081760691883;5256.789728410859;5256.9474305256845;5256.421793602701;5481.643693159932;5520.641158324716;5581.916271255935;5605.859853503654;5301.3373328333955;5355.464453554652;5418.539424148952;5419.430959749248;5424.538914192299;11907.22603030809;12144.149909506337;12147.696307592292;12149.93925030378;12218;2090.811826935583;2201.4716468047714;2222.14447437736;2229.933102006926;2236.865788052722;8851.77870553235;9397.718068457958;9454;9603.087706667855;9774.511274436321;1740.3299729604066;1748.3094177799699;1794.1657129434745;1802.648483545709;1807.0783900210988;75450.62274688591;75931.62034189794;77765;78889;80487;10194.133498652698;10443.738906527398;10520.316179448464;10699.572017119384;10700.143988480902;14494.420223190955;14581.198034108225;14582.343794529272;14599.124052556881;14606.707865842624;6907.240203577602;7120.857582848314;7169.749058783022;7196.784096477114;7271.272872712686;6610.933890661128;6662.467002639777;6850.212225594021;6901.378875901193;6914.619695916672;4304.375865499485;4405.995272151164;4449.777511124431;4494.775261236925;4586.793594288265;1843.8617103717274;1874.9062546872601;1905.4188472515739;1908.293931245448;1910.6083252933115;817.3910436724559;839.3201506779528;839.4040231435749;848.974530764078;882.571952602987;16061.839381606269;16798.748018779726;17060;17536.123193840256;17992.640147196984;833.1293797981003;843.0852525010309;847.1359213602092;851.7657644147785;866.3026263857655;9648.662296819719;9712.417254964725;9745.512724363753;9776.266779991529;9982.151517120981;568273;573895;578384.5130840801;579942;596486.228395153;70466.64766676133;82742;84486.577567113;102004;102694.48652756689;914.1133100892124;944.7071407863584;945.7210123013728;946.1626460582435;954.1889394015031;15947.760783588488;15994.360225590846;16158.757618635966;16371.09958952269;16667.91666041662;36724.81637591795;37553.43669845009;38075.61924380721;40802.1839563213;43810.78094609507;56660;57503.42496574981;58064.709676453036;58471.57493019257;59326.40673593209;4827.806887724592;4884.072026314989;7306.9770232166475;7577.393808495417;7897.407694422826;11095.72260693489;12624;12624.495020199089;12641.683957900757;12691.238525688488;10891.836622450512;10915.290506117077;10954.616588419367;11183.105351572018;11296.209265351346;10720.195985300978;10852.782944340912;10964.725881853017;11033.172512061788;11107.833382499108;10800.513976870903;10893.564257429614;10979;11217.55129794799;11305.43472826339;7989.520628762293;8008.439409241297;8131.349492040741;8141.185881412049;8244.876326855221;10364.740881478023;10678.519466624177;10686.358818470917;10718.785624287315;11054.22620416563 09:12:41 INFO - PROCESS | 21779 | |3;mootools.html;1279.36031984008;1296.9675758106052;1298.7337595792858;1307.8299821023265;1311.4164196932363;5962.761489540413;6165.691715414234;6354.586951848127;6656.9667151664235;6704.966475167629;6288.811335659926;6511.869762604745;6528;6690.163729533809;6717;2045.8158765711082;2074.408793493855;2075.2529089527757;2079;2083.1250874632615;1976.8616196866153;1991.5817678287576;2053.661145910923;2056.753189617248;2060.546679730457;2052.6818343156833;2073.9274125405614;2074.4191626344573;2076.086521930346;2076.5431605046865;1984.7022946557988;1999.780024197337;2010.447127040061;2017.9798202018012;2020.444377796103;2034.6541088014924;2056.321413933413;2057.4856285928518;2071.5856828634182;2093.9162433502643;6481.83795405114;6516.478681705452;6663.267040625527;6685.93314066858;6703.9329606703795;4085;4175.06061136245;4177.561356057631;4187.120704651997;4188.497380314351;2537.847729136239;2788.665360156794;2820.4077143799623;2826.222788733094;2831.5327970884778;1105.0883021507289;1108.7228192951761;1126.048489026771;1143.7998350288667;1154.7805916875766;8338.916610833874;8377.162283771635;8397.496150230945;8423.70517031901;8474.983002039795;3551.3430015446706;3551.4317709166407;3636.8727094551564;3679.411294192916;3734.215814678948;6691.297413771581;6726.159230096238;6730.32696730323;6742.292059333798;6767.086443330186;4029.992501874531;4042.6765858731233;4082.714210005271;4088.2436749201493;4147.460830092069;3825;3909.980450097731;3963.900902477461;3966.7619942803526;3979.3633018716864;3092.4537731134433;3096.2259435141214;3149.2599239178776;3195.2331440454122;3272.6236482804306;890.7505898348472;910.1490106750209;915.8809354783835;966.0387914025449;977.7751117243074;841.6759547574228;841.8526757817358;843.7510934274404;865.7099871543104;867.3624885708999;4578.725276483422;4622.884427889329;4649.721016739007;4657.4876763555985;4697.389339385858;881.6164968238836;898.9056149104381;899.6041741633791;899.6671231644334;900.2842740021698;3263.608366995928;3282.031800618823;3312.403767321905;3372.662733726657;3427.691507764313;7503.962480187564;7812.648430820626;7814;7820.804479887935;7837.3338266246865;7708.344790692854;7716.2669546393;7722.189170137167;7729.536227826348;7736.806579835549;6207.6585787781205;6310.9368906311265;6320.241571011508;6339.587926784744;6400.23197216337;4603.792829322621;4626.236670949255;4685.1332503486965;4715.717056976592;4762.714237145644;7062.752803651848;7078.716851326095;7105.0408194893025;7140.642967851691;7226.7109315626785;7161.928380716335;7176.425885929218;7298.197198308076;7303.30618591233;7308.04995350601;5323.574114070788;5385.138377859524;5388.46115388458;5391.32608423947;5401.891962160814;6048.334683184934;6074;6113.602615829956;6118.785842495491;6159.538034647329;5739.139129130664;5766.682832444256;5785.39253378406;5787.276590426197;5813.912791308049;5698.1737648041635;5778.191053252632;5780.739866705924;5791.710414479344;5866.149408335853;5168.819091331786;5258.553022992935;5259.053370393366;5266.868328291824;5267.789288428573;4106.979465102655;4130.855420060284;4143.440635514287;4194.182134483746;4242.045539753531;4031.209362808787;4105.548389677193;4122.113745544722;4160.687948403943;4227.7040607157205 09:12:41 INFO - PROCESS | 21779 | |4;prototype.html;332.1165699240022;346.9531613232213;353.4397979202963;353.48567833801815;357.8962100990714;4821.541953514419;4914.778834952427;5049.621278404121;5072.2391641253835;5078.746062696864;4772.80908763649;4909.705417674933;4942.5304596063315;4970.403551573816;4981.153203955328;3995.240904228202;4008.418779277003;4011.679065674739;4032.43545903573;4036.313826649462;3897.707671924603;3979.721419500622;3994.001499625094;4004.3993400989793;4005.879823605282;3955.624215699504;3957.5844536323702;3980.8606698765548;3993.7803420811842;4000.179963107556;3972.192652343191;3979.86070487533;3980.960190398117;3983.980080099581;4010.6590939770153;3559;3559.288142371536;3563.3786627084614;3590.389633762267;3593.730470214718;4657.650676199299;4869.488703686097;4872.7585310757095;4906.681065730716;4919.434265059493;4570.131674981776;4574.089153773509;4579.885677739136;4594.977025114887;4609.907801843944;5205.531502164823;5207.869803254911;5214.895702085937;5234.241035049935;5236.188390799432;3408.1820363112924;3592.910177245564;3859.591249194052;3889.105505733669;3896.980515097435;5465.617406781527;5469.288992430958;5484;5488.835334939959;5501.669899806025;3757.436384542286;3764.3976963686227;3777.6788972937607;3790.696744260508;3807.7144214184045;3780.319542482325;3791.5071040765074;3797.981010094987;3810.256999884996;3810.923781524354;4170.979145104255;4338.370936214231;4382.364557139197;4386.890327741832;4424.203643344164;5270.1040823060175;5288.497592728685;5297.973510132425;5302.2311764793885;5306.416294207634;1220.231254309797;1239.3369547292336;1249.5688987299368;1251.5494422008069;1258.3205069262497;860.6213266162869;864.7492227254025;866.0906048649019;871.9084496127942;878.0955615715823;4399.736015838996;4410;4419.011444849831;4420.342371610646;4450.577195166454;5118.744062796845;5142.537171654569;5149.356330458692;5165.044466773659;5172.508611681884;4326.459192600925;4607.7004994675235;4619.353290539327;4621.168189725814;4637.5130611286;2772.431651511435;2803.4393121375806;2808.817426867247;2811.479876222905;2824.943501129966;4641.466231383434;4869.806897310182;4916.213405855046;4943.90112197754;4951.925721114186;5290.931259869267;5338.599605029638;5350.91973620396;5355.598330125256;5378.327709036371;4880.438749543848;4910.238912968495;4911.803527858917;4922.680025798383;4930.890549626305;5067.366579177603;5177.275181474672;5197.596648904851;5202.947970520247;5302.310699609026;5100.821471248489;5175.430702622783;5193.610479213999;5199.4020687621405;5234.52889239955;4918.754062296799;4926.211806111005;4949.653524253267;4954.727489988085;4955.40535135786;3562.4300111982993;3622.9818850905576;3639.398664587573;3650.762700424464;3653.4337177737493;5356.196570514454;5381.19282107687;5381.67709937405;5386.767939236427;5395.838124856261;5191.714455704972;5201.895962080662;5241;5267.367915850123;5326.147816349366;4959.900801984012;5111.539961403343;5230.660007099526;5264.52619264268;5269.947300526946;4922.310876477224;5015.749212539431;5044.571211446922;5090.440051594395;5095.719735414587;5199.506046925536;5206.869828254324;5213.661112027706;5221.817236396708;5257.553107985864;5095.464976177596;5115.82577404609;5122.897542049063;5123.462036486116;5123.6157288202785 09:12:41 INFO - PROCESS | 21779 | |5;yui.html;668.7258224128109;675.0818886314611;732.1676932247166;756.5082696247439;779.9376049916008;12183.695407614814;13373.465061397557;13375.7324853503;13448.68812040819;13475.191488510673;11371.488283027264;11512.942435287812;11674.124440666941;11681.941590292057;11902.583409580666;791.4973991515401;794.4835856693167;822.7655118291289;833.0253603284172;834.0783434305097;834.1950018232404;836.4730219961447;838.9748307550752;840.470503582742;841.0202114536557;856.1866227084264;856.5845564901018;856.6230858422274;858.5020688000976;860.2300940658107;853.0445900591316;853.5689476814231;855.7518319687283;855.8288342331527;856.7900864288258;624.4348864277836;624.44736408279;624.725120946782;625.0093601641404;625.3746253746253;14156.858431415658;14411;14577.344019519147;14730.042547234396;14741.336639851232;13270.86729132706;13783.729961166942;13788.712990455695;13833.170009799444;13884;10697.09074728649;10722.356658600509;10758.623448179354;10883.891161088446;10970.451477426177;3285.720713739335;3319.618243901934;3341.231516751161;3378.594568651753;3450.1719587299117;70737.29262707359;71953.6402317985;73363.26636733618;74092;74262.05903527705;9867.30928834989;10543.683689489328;10630.468476576294;11040.33757974524;11101.777964440666;20242.392728218176;20268;20411.387658370273;20427;20492.487687807923;6387.648679322682;6517.348265173539;6670.032845237511;6683.933160668331;6739.123913891261;3491.965080349215;3592.1378869071236;3595.442706380515;3598.47822065799;3674.4488326750666;2660.401409682806;2802.677692065398;2805.438912217565;2821.8871245150376;2837.177218606581;535.154455959583;537.4249552978354;539.3581637850945;540.4406439335269;551.8013515134548;638.2946843737695;652.1815122021927;652.4584594786317;654.0646874968841;654.6792071884743;8683.175098365646;8762.824743505222;9393.483358415353;9409.576569054409;9960.501974901226;533.6717918480184;534.8315280686571;541.6587549843573;544.6106034185576;552.9419410961791;4273.047964514338;4314.849652124586;4519.796609152596;4525.162844873709;4651.744154071558;61701.38298617046;66288.6685566569;66594;66879.66560167167;67005.66497167484;59843.10235346473;60565.394346056855;61108.69445652832;61441;61884.690576546825;53179.468205318226;53573.196402054;53768;55596.16605750998;56339;8379.49723016621;8721.65113395457;8753;8794.252488538546;8940.240079593308;37080.25839483141;38498.6150138495;39263;39412.211755764154;39437;46822.53177468182;48214.75892620515;48477;48669;49307.7534612339;10705.825213849044;10783.622573210214;11026;11028.779424411627;11202.271852329572;11652.30086194831;11674.299542027506;11801.940990294994;11826.881731182579;12714.364281786058;10709.839352409565;10967.890321097006;11185.384803835866;11603.883961160618;11655;11251;11531.365774882463;11826.82259766087;11948.820767688318;12007.519699211934;10847.891521085005;11222.831657524981;11363.204575679623;11399.943000285277;11654.76690466169;9284.814303714023;9304.627814887599;9537.856932145885;9594.66418675343;9863.654772082942;8980.955095224483;9420;9511.286653501153;9526.380785248937;9546.809063818546 09:12:41 INFO - PROCESS | 21779 | __end_tp_report 09:12:41 INFO - PROCESS | 21779 | __start_cc_report 09:12:41 INFO - PROCESS | 21779 | _x_x_mozilla_cycle_collect,343 09:12:41 INFO - PROCESS | 21779 | __end_cc_report 09:12:41 INFO - PROCESS | 21779 | __startTimestamp1483809161415__endTimestamp 09:12:41 INFO - PROCESS | 21779 | 09:12:41 INFO - PROCESS | 21779 | ------- Summary: start ------- 09:12:41 INFO - PROCESS | 21779 | Number of tests: 6 09:12:41 INFO - PROCESS | 21779 | 09:12:41 INFO - PROCESS | 21779 | [#0] dojo.html Cycles:165 Average:4671.06 Median:4805.33 stddev:485.00 (10.1%) stddev-sans-first:458.35 09:12:41 INFO - PROCESS | 21779 | Values: 2595.9 2597.9 2607.4 2625.1 2628.9 4647.9 4690.7 4725.8 4737.7 4749.0 4668.0 4684.9 4735.4 4737.3 4812.6 4337.4 4385.5 4402.4 4456.3 4486.8 3988.6 4422.5 4427.1 4449.4 4453.2 4309.1 4364.3 4374.7 4410.8 4475.4 4319.0 4330.5 4340.7 4361.5 4363.4 4310.2 4328.7 4331.6 4343.9 4373.1 4567.6 4652.3 4668.4 4669.0 4706.4 4864.4 4903.1 5019.3 5045.4 5057.8 5084.6 5104.8 5108.5 5112.1 5133.4 4734.2 4742.3 4746.4 4760.1 4768.2 5043.0 5085.9 5096.5 5153.6 5234.7 4849.3 4909.9 4910.8 4937.4 4949.6 5008.3 5015.8 5024.4 5026.4 5027.5 4989.8 4995.4 4998.5 5008.7 5018.1 4937.8 4981.3 4982.0 4982.8 4998.1 4271.8 4305.8 4307.7 4314.4 4318.3 3689.0 3707.0 3740.1 3782.8 3789.9 4374.7 4376.4 4378.1 4385.9 4432.0 5000.5 5040.3 5058.8 5060.2 5107.6 4361.6 4396.3 4397.7 4413.8 4462.0 4515.4 4581.1 4589.8 4598.4 4642.6 4704.4 4797.5 4801.9 4803.7 4839.7 5034.2 5034.3 5062.4 5064.7 5178.0 4786.9 4793.5 4798.7 4805.3 4837.8 4972.6 5008.1 5020.5 5026.3 5064.7 4953.5 5002.5 5026.7 5047.8 5074.0 4927.4 4933.5 4935.3 4940.0 4968.9 4818.6 4857.7 4863.3 4916.9 4965.6 4768.1 4875.5 4904.4 4910.1 4945.1 4918.2 4981.9 4985.5 5005.6 5023.7 4841.1 4853.8 4858.1 4879.3 4901.8 09:12:41 INFO - PROCESS | 21779 | 09:12:41 INFO - PROCESS | 21779 | [#1] ext.html Cycles:180 Average:51459.70 Median:19775.74 stddev:112585.51 (569.3%) stddev-sans-first:112836.38 09:12:41 INFO - PROCESS | 21779 | Values: 517.3 531.8 532.7 537.4 554.7 39664.8 40969.4 41041.6 41154.8 44817.3 41064.6 41327.6 41417.6 41502.2 41561.2 7697.9 7858.8 7863.3 7870.8 9453.2 9565.7 9742.9 9750.2 9750.8 9756.3 9794.1 9852.1 9855.5 9873.7 9881.3 9661.0 9718.8 9740.7 9762.7 9765.7 9637.0 9704.9 9714.4 9718.1 9721.4 34275.0 34441.1 34492.8 34512.7 34605.5 3567.0 3620.4 3634.7 3649.5 3676.6 25513.0 25938.2 25938.5 25942.9 26312.5 3468.1 3511.9 3594.5 3648.7 3675.7 232352.0 233085.0 233541.0 234028.0 235449.0 42960.8 43161.6 43328.0 47411.5 47784.5 48564.3 48670.8 48673.8 48675.5 48683.0 13335.7 13744.9 13764.9 13838.7 13913.2 9470.9 9675.4 9719.7 9816.6 10636.8 16219.3 16228.4 16387.4 16437.3 16467.8 6391.4 6425.6 6454.6 6462.5 6778.6 810.9 837.6 839.9 843.5 863.6 27275.5 28005.2 28184.3 28217.0 28478.7 958.9 967.6 968.4 979.3 1041.6 14386.0 14686.9 14812.2 15131.2 15174.3 350954.0 628382.0 638362.0 644040.0 644105.0 43754.3 44260.8 44290.6 44303.3 44410.2 1202.9 1204.9 1236.4 1239.5 1242.3 25510.5 26047.0 26514.6 26779.2 27011.1 37709.6 38083.4 38119.4 38468.0 38673.4 347966.0 348816.0 349636.0 349792.0 350008.0 21645.1 21717.5 21726.3 23387.5 24061.5 34625.3 34863.3 35700.1 35740.0 35957.0 29793.6 30024.0 30048.8 30613.8 31047.8 29701.6 29859.3 30041.0 30445.0 30556.5 29531.9 29951.7 30151.7 30271.4 30277.9 22726.3 24955.9 25760.7 26580.0 27969.7 21431.8 21461.6 21645.0 21712.8 21714.6 09:12:41 INFO - PROCESS | 21779 | 09:12:41 INFO - PROCESS | 21779 | [#2] jquery.html Cycles:180 Average:30383.57 Median:4540.78 stddev:95190.77 (2096.4%) stddev-sans-first:95431.14 09:12:41 INFO - PROCESS | 21779 | Values: 375.7 384.2 386.8 401.4 403.4 17541.3 18384.9 18766.6 18794.2 18834.5 17901.9 17934.0 18124.4 18324.1 18365.7 5136.5 5193.1 5253.5 5312.3 5348.6 5108.5 5265.1 5272.0 5276.7 5276.8 5245.5 5246.2 5247.1 5256.8 5256.9 5256.4 5481.6 5520.6 5581.9 5605.9 5301.3 5355.5 5418.5 5419.4 5424.5 11907.2 12144.1 12147.7 12149.9 12218.0 2090.8 2201.5 2222.1 2229.9 2236.9 8851.8 9397.7 9454.0 9603.1 9774.5 1740.3 1748.3 1794.2 1802.6 1807.1 75450.6 75931.6 77765.0 78889.0 80487.0 10194.1 10443.7 10520.3 10699.6 10700.1 14494.4 14581.2 14582.3 14599.1 14606.7 6907.2 7120.9 7169.7 7196.8 7271.3 6610.9 6662.5 6850.2 6901.4 6914.6 4304.4 4406.0 4449.8 4494.8 4586.8 1843.9 1874.9 1905.4 1908.3 1910.6 817.4 839.3 839.4 849.0 882.6 16061.8 16798.7 17060.0 17536.1 17992.6 833.1 843.1 847.1 851.8 866.3 9648.7 9712.4 9745.5 9776.3 9982.2 568273.0 573895.0 578384.5 579942.0 596486.2 70466.6 82742.0 84486.6 102004.0 102694.5 914.1 944.7 945.7 946.2 954.2 15947.8 15994.4 16158.8 16371.1 16667.9 36724.8 37553.4 38075.6 40802.2 43810.8 56660.0 57503.4 58064.7 58471.6 59326.4 4827.8 4884.1 7307.0 7577.4 7897.4 11095.7 12624.0 12624.5 12641.7 12691.2 10891.8 10915.3 10954.6 11183.1 11296.2 10720.2 10852.8 10964.7 11033.2 11107.8 10800.5 10893.6 10979.0 11217.6 11305.4 7989.5 8008.4 8131.3 8141.2 8244.9 10364.7 10678.5 10686.4 10718.8 11054.2 09:12:41 INFO - PROCESS | 21779 | 09:12:41 INFO - PROCESS | 21779 | [#3] mootools.html Cycles:180 Average:4364.69 Median:5213.69 stddev:2219.54 (42.6%) stddev-sans-first:2213.66 09:12:41 INFO - PROCESS | 21779 | Values: 1279.4 1297.0 1298.7 1307.8 1311.4 5962.8 6165.7 6354.6 6657.0 6705.0 6288.8 6511.9 6528.0 6690.2 6717.0 2045.8 2074.4 2075.3 2079.0 2083.1 1976.9 1991.6 2053.7 2056.8 2060.5 2052.7 2073.9 2074.4 2076.1 2076.5 1984.7 1999.8 2010.4 2018.0 2020.4 2034.7 2056.3 2057.5 2071.6 2093.9 6481.8 6516.5 6663.3 6685.9 6703.9 4085.0 4175.1 4177.6 4187.1 4188.5 2537.8 2788.7 2820.4 2826.2 2831.5 1105.1 1108.7 1126.0 1143.8 1154.8 8338.9 8377.2 8397.5 8423.7 8475.0 3551.3 3551.4 3636.9 3679.4 3734.2 6691.3 6726.2 6730.3 6742.3 6767.1 4030.0 4042.7 4082.7 4088.2 4147.5 3825.0 3910.0 3963.9 3966.8 3979.4 3092.5 3096.2 3149.3 3195.2 3272.6 890.8 910.1 915.9 966.0 977.8 841.7 841.9 843.8 865.7 867.4 4578.7 4622.9 4649.7 4657.5 4697.4 881.6 898.9 899.6 899.7 900.3 3263.6 3282.0 3312.4 3372.7 3427.7 7504.0 7812.6 7814.0 7820.8 7837.3 7708.3 7716.3 7722.2 7729.5 7736.8 6207.7 6310.9 6320.2 6339.6 6400.2 4603.8 4626.2 4685.1 4715.7 4762.7 7062.8 7078.7 7105.0 7140.6 7226.7 7161.9 7176.4 7298.2 7303.3 7308.0 5323.6 5385.1 5388.5 5391.3 5401.9 6048.3 6074.0 6113.6 6118.8 6159.5 5739.1 5766.7 5785.4 5787.3 5813.9 5698.2 5778.2 5780.7 5791.7 5866.1 5168.8 5258.6 5259.1 5266.9 5267.8 4107.0 4130.9 4143.4 4194.2 4242.0 4031.2 4105.5 4122.1 4160.7 4227.7 09:12:41 INFO - PROCESS | 21779 | 09:12:41 INFO - PROCESS | 21779 | [#4] prototype.html Cycles:180 Average:4308.93 Median:4911.02 stddev:1241.80 (25.3%) stddev-sans-first:1208.87 09:12:41 INFO - PROCESS | 21779 | Values: 332.1 347.0 353.4 353.5 357.9 4821.5 4914.8 5049.6 5072.2 5078.7 4772.8 4909.7 4942.5 4970.4 4981.2 3995.2 4008.4 4011.7 4032.4 4036.3 3897.7 3979.7 3994.0 4004.4 4005.9 3955.6 3957.6 3980.9 3993.8 4000.2 3972.2 3979.9 3981.0 3984.0 4010.7 3559.0 3559.3 3563.4 3590.4 3593.7 4657.7 4869.5 4872.8 4906.7 4919.4 4570.1 4574.1 4579.9 4595.0 4609.9 5205.5 5207.9 5214.9 5234.2 5236.2 3408.2 3592.9 3859.6 3889.1 3897.0 5465.6 5469.3 5484.0 5488.8 5501.7 3757.4 3764.4 3777.7 3790.7 3807.7 3780.3 3791.5 3798.0 3810.3 3810.9 4171.0 4338.4 4382.4 4386.9 4424.2 5270.1 5288.5 5298.0 5302.2 5306.4 1220.2 1239.3 1249.6 1251.5 1258.3 860.6 864.7 866.1 871.9 878.1 4399.7 4410.0 4419.0 4420.3 4450.6 5118.7 5142.5 5149.4 5165.0 5172.5 4326.5 4607.7 4619.4 4621.2 4637.5 2772.4 2803.4 2808.8 2811.5 2824.9 4641.5 4869.8 4916.2 4943.9 4951.9 5290.9 5338.6 5350.9 5355.6 5378.3 4880.4 4910.2 4911.8 4922.7 4930.9 5067.4 5177.3 5197.6 5202.9 5302.3 5100.8 5175.4 5193.6 5199.4 5234.5 4918.8 4926.2 4949.7 4954.7 4955.4 3562.4 3623.0 3639.4 3650.8 3653.4 5356.2 5381.2 5381.7 5386.8 5395.8 5191.7 5201.9 5241.0 5267.4 5326.1 4959.9 5111.5 5230.7 5264.5 5269.9 4922.3 5015.7 5044.6 5090.4 5095.7 5199.5 5206.9 5213.7 5221.8 5257.6 5095.5 5115.8 5122.9 5123.5 5123.6 09:12:41 INFO - PROCESS | 21779 | 09:12:41 INFO - PROCESS | 21779 | [#5] yui.html Cycles:180 Average:15476.24 Median:534.25 stddev:19762.23 (3699.0%) stddev-sans-first:19786.38 09:12:41 INFO - PROCESS | 21779 | Values: 668.7 675.1 732.2 756.5 779.9 12183.7 13373.5 13375.7 13448.7 13475.2 11371.5 11512.9 11674.1 11681.9 11902.6 791.5 794.5 822.8 833.0 834.1 834.2 836.5 839.0 840.5 841.0 856.2 856.6 856.6 858.5 860.2 853.0 853.6 855.8 855.8 856.8 624.4 624.4 624.7 625.0 625.4 14156.9 14411.0 14577.3 14730.0 14741.3 13270.9 13783.7 13788.7 13833.2 13884.0 10697.1 10722.4 10758.6 10883.9 10970.5 3285.7 3319.6 3341.2 3378.6 3450.2 70737.3 71953.6 73363.3 74092.0 74262.1 9867.3 10543.7 10630.5 11040.3 11101.8 20242.4 20268.0 20411.4 20427.0 20492.5 6387.6 6517.3 6670.0 6683.9 6739.1 3492.0 3592.1 3595.4 3598.5 3674.4 2660.4 2802.7 2805.4 2821.9 2837.2 535.2 537.4 539.4 540.4 551.8 638.3 652.2 652.5 654.1 654.7 8683.2 8762.8 9393.5 9409.6 9960.5 533.7 534.8 541.7 544.6 552.9 4273.0 4314.8 4519.8 4525.2 4651.7 61701.4 66288.7 66594.0 66879.7 67005.7 59843.1 60565.4 61108.7 61441.0 61884.7 53179.5 53573.2 53768.0 55596.2 56339.0 8379.5 8721.7 8753.0 8794.3 8940.2 37080.3 38498.6 39263.0 39412.2 39437.0 46822.5 48214.8 48477.0 48669.0 49307.8 10705.8 10783.6 11026.0 11028.8 11202.3 11652.3 11674.3 11801.9 11826.9 12714.4 10709.8 10967.9 11185.4 11603.9 11655.0 11251.0 11531.4 11826.8 11948.8 12007.5 10847.9 11222.8 11363.2 11399.9 11654.8 9284.8 9304.6 9537.9 9594.7 9863.7 8981.0 9420.0 9511.3 9526.4 9546.8 09:12:41 INFO - PROCESS | 21779 | -------- Summary: end -------- 09:12:41 INFO - PROCESS | 21779 | 09:12:42 INFO - TEST-INFO | 21779: exit 0 09:12:42 INFO - TEST-OK | dromaeo_css | took 1119756ms 09:12:42 INFO - TEST-START | kraken 09:12:42 INFO - operating with platform_type : linux_ 09:12:42 INFO - Initialising browser for kraken test... 09:12:42 INFO - TEST-INFO | started process 22138 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPNXAS0/profile http://localhost:33839/getInfo.html) 09:12:42 INFO - PROCESS | 22138 | 1483809162787 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 09:12:46 INFO - PROCESS | 22138 | __metrics Screen width/height:1600/1200 09:12:46 INFO - PROCESS | 22138 | colorDepth:24 09:12:46 INFO - PROCESS | 22138 | Browser inner width/height: 1024/697 09:12:46 INFO - PROCESS | 22138 | __metrics 09:12:47 ERROR - PROCESS | 22138 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 09:12:48 INFO - TEST-INFO | 22138: exit 0 09:12:48 INFO - Browser initialized. 09:12:48 INFO - Running cycle 1/1 for kraken test... 09:12:48 INFO - TEST-INFO | started process 22259 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPNXAS0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:13:00 INFO - PROCESS | 22259 | RSS: Main: 158887936 09:13:00 INFO - PROCESS | 22259 | 09:13:03 INFO - PROCESS | 22259 | Cycle 1(1): loaded http://localhost:33839/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33839/tests/kraken/driver.html?testName=audio-beat-detection) 09:13:04 INFO - PROCESS | 22259 | RSS: Main: 164794368 09:13:04 INFO - PROCESS | 22259 | 09:13:06 INFO - PROCESS | 22259 | Cycle 1(1): loaded http://localhost:33839/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33839/tests/kraken/driver.html?testName=audio-dft) 09:13:07 INFO - PROCESS | 22259 | RSS: Main: 164290560 09:13:07 INFO - PROCESS | 22259 | 09:13:10 INFO - PROCESS | 22259 | Cycle 1(1): loaded http://localhost:33839/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33839/tests/kraken/driver.html?testName=audio-fft) 09:13:10 INFO - PROCESS | 22259 | RSS: Main: 160874496 09:13:10 INFO - PROCESS | 22259 | 09:13:13 INFO - PROCESS | 22259 | Cycle 1(1): loaded http://localhost:33839/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33839/tests/kraken/driver.html?testName=audio-oscillator) 09:13:13 INFO - PROCESS | 22259 | RSS: Main: 161316864 09:13:13 INFO - PROCESS | 22259 | 09:13:15 INFO - PROCESS | 22259 | Cycle 1(1): loaded http://localhost:33839/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33839/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:13:16 INFO - PROCESS | 22259 | RSS: Main: 161488896 09:13:16 INFO - PROCESS | 22259 | 09:13:19 INFO - PROCESS | 22259 | Cycle 1(1): loaded http://localhost:33839/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33839/tests/kraken/driver.html?testName=imaging-darkroom) 09:13:20 INFO - PROCESS | 22259 | RSS: Main: 167034880 09:13:20 INFO - PROCESS | 22259 | 09:13:23 INFO - PROCESS | 22259 | Cycle 1(1): loaded http://localhost:33839/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33839/tests/kraken/driver.html?testName=imaging-desaturate) 09:13:24 INFO - PROCESS | 22259 | RSS: Main: 162615296 09:13:24 INFO - PROCESS | 22259 | 09:13:27 INFO - PROCESS | 22259 | Cycle 1(1): loaded http://localhost:33839/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33839/tests/kraken/driver.html?testName=json-parse-financial) 09:13:28 INFO - PROCESS | 22259 | RSS: Main: 164184064 09:13:28 INFO - PROCESS | 22259 | 09:13:29 INFO - PROCESS | 22259 | Cycle 1(1): loaded http://localhost:33839/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33839/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:13:30 INFO - PROCESS | 22259 | RSS: Main: 164311040 09:13:30 INFO - PROCESS | 22259 | 09:13:32 INFO - PROCESS | 22259 | Cycle 1(1): loaded http://localhost:33839/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33839/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:13:32 INFO - PROCESS | 22259 | RSS: Main: 164589568 09:13:32 INFO - PROCESS | 22259 | 09:13:35 INFO - PROCESS | 22259 | Cycle 1(1): loaded http://localhost:33839/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33839/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:13:35 INFO - PROCESS | 22259 | RSS: Main: 164888576 09:13:35 INFO - PROCESS | 22259 | 09:13:38 INFO - PROCESS | 22259 | Cycle 1(1): loaded http://localhost:33839/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33839/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:13:39 INFO - PROCESS | 22259 | RSS: Main: 165593088 09:13:39 INFO - PROCESS | 22259 | 09:13:42 INFO - PROCESS | 22259 | Cycle 1(1): loaded http://localhost:33839/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33839/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:13:43 INFO - PROCESS | 22259 | RSS: Main: 164814848 09:13:43 INFO - PROCESS | 22259 | 09:13:44 INFO - PROCESS | 22259 | Cycle 1(1): loaded http://localhost:33839/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33839/tests/kraken/driver.html?testName=ai-astar) 09:13:45 INFO - PROCESS | 22259 | RSS: Main: 166424576 09:13:45 INFO - PROCESS | 22259 | 09:13:45 INFO - PROCESS | 22259 | __start_tp_report 09:13:45 INFO - PROCESS | 22259 | _x_x_mozilla_page_load 09:13:45 INFO - PROCESS | 22259 | _x_x_mozilla_page_load_details 09:13:45 INFO - PROCESS | 22259 | |i|pagename|runs| 09:13:45 INFO - PROCESS | 22259 | |0;ai-astar;109;116;116;115;116;116;116;115;115;115 09:13:45 INFO - PROCESS | 22259 | |1;audio-beat-detection;160;131;131;176;126;126;125;124;144;123 09:13:45 INFO - PROCESS | 22259 | |2;audio-dft;164;165;165;173;163;162;161;163;162;162 09:13:45 INFO - PROCESS | 22259 | |3;audio-fft;77;77;77;115;81;79;77;80;92;78 09:13:45 INFO - PROCESS | 22259 | |4;audio-oscillator;93;86;103;85;89;86;100;86;86;115 09:13:45 INFO - PROCESS | 22259 | |5;imaging-gaussian-blur;118;120;117;118;118;123;117;119;119;117 09:13:45 INFO - PROCESS | 22259 | |6;imaging-darkroom;151;152;150;151;152;150;151;150;150;151 09:13:45 INFO - PROCESS | 22259 | |7;imaging-desaturate;101;96;96;97;97;96;96;97;96;96 09:13:45 INFO - PROCESS | 22259 | |8;json-parse-financial;66;67;66;67;67;68;67;68;66;73 09:13:45 INFO - PROCESS | 22259 | |9;json-stringify-tinderbox;68;67;67;67;67;66;66;66;67;67 09:13:45 INFO - PROCESS | 22259 | |10;stanford-crypto-aes;86;86;92;91;84;89;86;92;90;85 09:13:45 INFO - PROCESS | 22259 | |11;stanford-crypto-ccm;143;147;137;136;133;144;134;143;190;132 09:13:45 INFO - PROCESS | 22259 | |12;stanford-crypto-pbkdf2;182;184;187;176;183;179;179;183;175;176 09:13:45 INFO - PROCESS | 22259 | |13;stanford-crypto-sha256-iterative;69;79;71;76;68;70;69;68;67;70 09:13:45 INFO - PROCESS | 22259 | __end_tp_report 09:13:45 INFO - PROCESS | 22259 | __start_cc_report 09:13:45 INFO - PROCESS | 22259 | _x_x_mozilla_cycle_collect,817 09:13:45 INFO - PROCESS | 22259 | __end_cc_report 09:13:45 INFO - PROCESS | 22259 | __startTimestamp1483809225094__endTimestamp 09:13:45 INFO - PROCESS | 22259 | 09:13:45 INFO - PROCESS | 22259 | ------- Summary: start ------- 09:13:45 INFO - PROCESS | 22259 | Number of tests: 14 09:13:45 INFO - PROCESS | 22259 | 09:13:45 INFO - PROCESS | 22259 | [#0] ai-astar Cycles:10 Average:114.90 Median:116.00 stddev:2.13 (1.8%) stddev-sans-first:0.53 09:13:45 INFO - PROCESS | 22259 | Values: 109.0 116.0 116.0 115.0 116.0 116.0 116.0 115.0 115.0 115.0 09:13:45 INFO - PROCESS | 22259 | 09:13:45 INFO - PROCESS | 22259 | [#1] audio-beat-detection Cycles:10 Average:136.60 Median:131.00 stddev:18.01 (13.8%) stddev-sans-first:17.00 09:13:45 INFO - PROCESS | 22259 | Values: 160.0 131.0 131.0 176.0 126.0 126.0 125.0 124.0 144.0 123.0 09:13:45 INFO - PROCESS | 22259 | 09:13:45 INFO - PROCESS | 22259 | [#2] audio-dft Cycles:10 Average:164.00 Median:163.50 stddev:3.43 (2.1%) stddev-sans-first:3.64 09:13:45 INFO - PROCESS | 22259 | Values: 164.0 165.0 165.0 173.0 163.0 162.0 161.0 163.0 162.0 162.0 09:13:45 INFO - PROCESS | 22259 | 09:13:45 INFO - PROCESS | 22259 | [#3] audio-fft Cycles:10 Average:83.30 Median:78.50 stddev:12.03 (15.3%) stddev-sans-first:12.54 09:13:45 INFO - PROCESS | 22259 | Values: 77.0 77.0 77.0 115.0 81.0 79.0 77.0 80.0 92.0 78.0 09:13:45 INFO - PROCESS | 22259 | 09:13:45 INFO - PROCESS | 22259 | [#4] audio-oscillator Cycles:10 Average:92.90 Median:86.00 stddev:10.05 (11.7%) stddev-sans-first:10.66 09:13:45 INFO - PROCESS | 22259 | Values: 93.0 86.0 103.0 85.0 89.0 86.0 100.0 86.0 86.0 115.0 09:13:45 INFO - PROCESS | 22259 | 09:13:45 INFO - PROCESS | 22259 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:118.50 stddev:1.84 (1.6%) stddev-sans-first:1.94 09:13:45 INFO - PROCESS | 22259 | Values: 118.0 120.0 117.0 118.0 118.0 123.0 117.0 119.0 119.0 117.0 09:13:45 INFO - PROCESS | 22259 | 09:13:45 INFO - PROCESS | 22259 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:151.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 09:13:45 INFO - PROCESS | 22259 | Values: 151.0 152.0 150.0 151.0 152.0 150.0 151.0 150.0 150.0 151.0 09:13:45 INFO - PROCESS | 22259 | 09:13:45 INFO - PROCESS | 22259 | [#7] imaging-desaturate Cycles:10 Average:96.80 Median:96.00 stddev:1.55 (1.6%) stddev-sans-first:0.50 09:13:45 INFO - PROCESS | 22259 | Values: 101.0 96.0 96.0 97.0 97.0 96.0 96.0 97.0 96.0 96.0 09:13:45 INFO - PROCESS | 22259 | 09:13:45 INFO - PROCESS | 22259 | [#8] json-parse-financial Cycles:10 Average:67.50 Median:67.00 stddev:2.07 (3.1%) stddev-sans-first:2.12 09:13:45 INFO - PROCESS | 22259 | Values: 66.0 67.0 66.0 67.0 67.0 68.0 67.0 68.0 66.0 73.0 09:13:45 INFO - PROCESS | 22259 | 09:13:45 INFO - PROCESS | 22259 | [#9] json-stringify-tinderbox Cycles:10 Average:66.80 Median:67.00 stddev:0.63 (0.9%) stddev-sans-first:0.50 09:13:45 INFO - PROCESS | 22259 | Values: 68.0 67.0 67.0 67.0 67.0 66.0 66.0 66.0 67.0 67.0 09:13:45 INFO - PROCESS | 22259 | 09:13:45 INFO - PROCESS | 22259 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:89.50 stddev:3.03 (3.4%) stddev-sans-first:3.12 09:13:45 INFO - PROCESS | 22259 | Values: 86.0 86.0 92.0 91.0 84.0 89.0 86.0 92.0 90.0 85.0 09:13:45 INFO - PROCESS | 22259 | 09:13:45 INFO - PROCESS | 22259 | [#11] stanford-crypto-ccm Cycles:10 Average:143.90 Median:143.00 stddev:17.01 (11.9%) stddev-sans-first:18.04 09:13:45 INFO - PROCESS | 22259 | Values: 143.0 147.0 137.0 136.0 133.0 144.0 134.0 143.0 190.0 132.0 09:13:45 INFO - PROCESS | 22259 | 09:13:45 INFO - PROCESS | 22259 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.40 Median:182.50 stddev:4.01 (2.2%) stddev-sans-first:4.21 09:13:45 INFO - PROCESS | 22259 | Values: 182.0 184.0 187.0 176.0 183.0 179.0 179.0 183.0 175.0 176.0 09:13:45 INFO - PROCESS | 22259 | 09:13:45 INFO - PROCESS | 22259 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:70.00 stddev:3.83 (5.5%) stddev-sans-first:4.01 09:13:45 INFO - PROCESS | 22259 | Values: 69.0 79.0 71.0 76.0 68.0 70.0 69.0 68.0 67.0 70.0 09:13:45 INFO - PROCESS | 22259 | -------- Summary: end -------- 09:13:45 INFO - PROCESS | 22259 | 09:13:46 INFO - TEST-INFO | 22259: exit 0 09:13:46 INFO - TEST-OK | kraken | took 63948ms 09:13:46 INFO - SUITE-END | took 1183s 09:13:46 INFO - Completed test suite (00:19:44) 09:13:46 INFO - javascript benchmark 09:13:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6290.037329429194, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2595.9480810383807, 2597.9220623381298, 2607.3611965068562, 2625.0943424518546, 2628.8817003234853, 4647.907041859161, 4690.718556886585, 4725.763711814408, 4737.73942433166, 4748.976255118729, 4667.976660116703, 4684.882877928054, 4735.3844000280005, 4737.289406589013, 4812.614990800736, 4337.392765012893, 4385.495667998173, 4402.361657559652, 4456.2647163218035, 4486.753228572427, 3988.601139886003, 4422.491413487442, 4427.1367083418745, 4449.399331090293, 4453.242948698729, 4309.095090031097, 4364.323529852878, 4374.671899607542, 4410.845620403286, 4475.440569928759, 4319.0, 4330.545292744248, 4340.65274778017, 4361.520232774392, 4363.36731173978, 4310.245707001293, 4328.696991210617, 4331.592232524411, 4343.913121737579, 4373.059792144672, 4567.634589232854, 4652.278896771006, 4668.393108895856, 4669.0, 4706.411698537683, 4864.416270047617, 4903.141950158708, 5019.29729837823, 5045.4197767256865, 5057.848264552033, 5084.593232541425, 5104.846854594368, 5108.5402313791565, 5112.130937740593, 5133.383993920754, 4734.171519983989, 4742.312364707098, 4746.38297021385, 4760.119377915097, 4768.165571025092, 5043.041822053798, 5085.923711144262, 5096.490350964874, 5153.639245252796, 5234.685918844882, 4849.321095046696, 4909.852704418873, 4910.803567857246, 4937.407511098691, 4949.628777841676, 5008.348914641147, 5015.82444614444, 5024.397072351268, 5026.421961474477, 5027.497250274943, 4989.750512474435, 4995.425526064477, 4998.500149985045, 5008.724520151354, 5018.096742586369, 4937.790241390882, 4981.32752078472, 4981.950180498221, 4982.750862456863, 4998.125328067574, 4271.765052922119, 4305.82776688929, 4307.6769242306955, 4314.374415709704, 4318.265894797892, 3689.0, 3707.0361705956648, 3740.102375429877, 3782.791946442972, 3789.9242015159543, 4374.715643483163, 4376.431063961664, 4378.0806030733265, 4385.934210986838, 4431.955680443154, 5000.4999500050435, 5040.31955685985, 5058.822941197041, 5060.240963855451, 5107.61692873036, 4361.6074553290355, 4396.296592545242, 4397.6921615487245, 4413.84551540701, 4462.0183559616835, 4515.412996310459, 4581.129585378767, 4589.839355622537, 4598.448186217675, 4642.628589712815, 4704.435467743892, 4797.496262892486, 4801.855944321676, 4803.663743537919, 4839.733814640158, 5034.194528875362, 5034.270030845581, 5062.392512898476, 5064.696118232918, 5178.0, 4786.904261914812, 4793.520647935178, 4798.664093513421, 4805.327254184487, 4837.7581120944515, 4972.577330926767, 5008.148614735431, 5020.548150666457, 5026.346574945233, 5064.670796398223, 4953.455119936732, 5002.52476014778, 5026.748662566784, 5047.848564543069, 5074.010567939216, 4927.408710954708, 4933.457319694759, 4935.309056731989, 4939.97530012362, 4968.925466118083, 4818.566329030404, 4857.732824694675, 4863.3434486343895, 4916.92624610624, 4965.577925876197, 4768.070226305976, 4875.463698993179, 4904.362432883845, 4910.06708725341, 4945.085159245551, 4918.163912134874, 4981.900361992813, 4985.451600323889, 5005.5745261653165, 5023.723695196799, 4841.12859685246, 4853.757312134449, 4858.149823780895, 4879.292502587176, 4901.803927842846], "value": 4639.978246787691, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [517.3119750731527, 531.7979167916192, 532.6511135206441, 537.4222710586121, 554.664428021047, 39664.80167599161, 40969.3854592181, 41041.589584104186, 41154.794226028906, 44817.32774008392, 41064.58935410645, 41327.58672413275, 41417.58582414175, 41502.16995660093, 41561.16877662445, 7697.884531732028, 7858.803529911741, 7863.292303692667, 7870.763877083668, 9453.243740500744, 9565.713028609152, 9742.853857192147, 9750.171235444996, 9750.804983900318, 9756.317057805956, 9794.118529332358, 9852.064053914866, 9855.457949812757, 9873.654422095227, 9881.258905582074, 9661.0, 9718.757031074245, 9740.659076932274, 9762.707118786448, 9765.658201962897, 9636.95181524095, 9704.854427183598, 9714.368566043184, 9718.12536871685, 9721.416714997053, 34275.0, 34441.138971525914, 34492.82753586216, 34512.65487345144, 34605.480917786255, 3567.0, 3620.402633565485, 3634.745567810254, 3649.4708267301357, 3676.6323367663285, 25513.0, 25938.22185334443, 25938.481230375288, 25942.870285648452, 26312.47375052488, 3468.0982944434377, 3511.929761404783, 3594.478800573902, 3648.72634552407, 3675.650813172744, 232352.0, 233085.0, 233541.0, 234028.0, 235449.0, 42960.78519607382, 43161.568384316386, 43328.0, 47411.5258847414, 47784.5221547787, 48564.271535926986, 48670.75664621654, 48673.75663121662, 48675.513244867805, 48683.0, 13335.733285334432, 13744.862551374557, 13764.862351376558, 13838.716611759148, 13913.23477208743, 9470.857937130948, 9675.419474831533, 9719.708408747749, 9816.558254878548, 10636.787264254672, 16219.27013284405, 16228.432004879773, 16387.42644007454, 16437.26032328524, 16467.752983705253, 6391.360863913665, 6425.58233714807, 6454.612723236527, 6462.547621666532, 6778.559393639398, 810.8621534339177, 837.6076888601262, 839.904950258288, 843.4939036578004, 863.6156910175038, 27275.45449091007, 28005.15984520468, 28184.29539261535, 28217.0, 28478.715212847605, 958.8801399825022, 967.6274634265858, 968.3560432312574, 979.3438396274513, 1041.578160844859, 14386.0, 14686.92656536732, 14812.185329806964, 15131.243437828065, 15174.317155728018, 350954.0, 628382.0, 638362.0, 644040.0, 644105.0, 43754.34368484475, 44260.77869610631, 44290.557094429285, 44303.335449968275, 44410.22821006375, 1202.9182638803018, 1204.9096317776202, 1236.4436003798507, 1239.4794186441716, 1242.2794779028143, 25510.48979020372, 26047.0, 26514.602280965417, 26779.196624101307, 27011.054613088447, 37709.622903770614, 38083.428748568236, 38119.42820857745, 38468.0, 38673.41989870098, 347966.0, 348816.0, 349636.0, 349792.0, 350008.0, 21645.13419463267, 21717.457063573536, 21726.34820955374, 23387.53224935526, 24061.51876962486, 34625.307493849476, 34863.30273394569, 35700.107497312776, 35740.0, 35957.0, 29793.553096703134, 30024.0, 30048.849755751082, 30613.775448981793, 31047.84476077605, 29701.5544766833, 29859.253518662208, 30041.0, 30445.0, 30556.541651875683, 29531.852340738158, 29951.700482994893, 30151.69848301489, 30271.394572108875, 30277.94027209037, 22726.31821045371, 24955.87522062378, 25760.742392575834, 26580.0, 27969.72030279671, 21431.838975297396, 21461.570768584854, 21645.0, 21712.782872171076, 21714.565708686056], "value": 17140.45452617404, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.66753423220456, 384.2277023183402, 386.7795356646711, 401.3898873711956, 403.3747691078827, 17541.298348066077, 18384.908075459636, 18766.59250556207, 18794.15426305816, 18834.529136771587, 17901.91049044756, 17934.0, 18124.36564720235, 18324.083795810224, 18365.7245141323, 5136.512031357015, 5193.1171700810955, 5253.50091741284, 5312.3093997780425, 5348.598855085865, 5108.540231379176, 5265.078611243036, 5271.998320319127, 5276.683398996053, 5276.788928442877, 5245.527902488775, 5246.239295302179, 5247.081760691883, 5256.789728410859, 5256.9474305256845, 5256.421793602701, 5481.643693159932, 5520.641158324716, 5581.916271255935, 5605.859853503654, 5301.3373328333955, 5355.464453554652, 5418.539424148952, 5419.430959749248, 5424.538914192299, 11907.22603030809, 12144.149909506337, 12147.696307592292, 12149.93925030378, 12218.0, 2090.811826935583, 2201.4716468047714, 2222.14447437736, 2229.933102006926, 2236.865788052722, 8851.77870553235, 9397.718068457958, 9454.0, 9603.087706667855, 9774.511274436321, 1740.3299729604066, 1748.3094177799699, 1794.1657129434745, 1802.648483545709, 1807.0783900210988, 75450.62274688591, 75931.62034189794, 77765.0, 78889.0, 80487.0, 10194.133498652698, 10443.738906527398, 10520.316179448464, 10699.572017119384, 10700.143988480902, 14494.420223190955, 14581.198034108225, 14582.343794529272, 14599.124052556881, 14606.707865842624, 6907.240203577602, 7120.857582848314, 7169.749058783022, 7196.784096477114, 7271.272872712686, 6610.933890661128, 6662.467002639777, 6850.212225594021, 6901.378875901193, 6914.619695916672, 4304.375865499485, 4405.995272151164, 4449.777511124431, 4494.775261236925, 4586.793594288265, 1843.8617103717274, 1874.9062546872601, 1905.4188472515739, 1908.293931245448, 1910.6083252933115, 817.3910436724559, 839.3201506779528, 839.4040231435749, 848.974530764078, 882.571952602987, 16061.839381606269, 16798.748018779726, 17060.0, 17536.123193840256, 17992.640147196984, 833.1293797981003, 843.0852525010309, 847.1359213602092, 851.7657644147785, 866.3026263857655, 9648.662296819719, 9712.417254964725, 9745.512724363753, 9776.266779991529, 9982.151517120981, 568273.0, 573895.0, 578384.5130840801, 579942.0, 596486.228395153, 70466.64766676133, 82742.0, 84486.577567113, 102004.0, 102694.48652756689, 914.1133100892124, 944.7071407863584, 945.7210123013728, 946.1626460582435, 954.1889394015031, 15947.760783588488, 15994.360225590846, 16158.757618635966, 16371.09958952269, 16667.91666041662, 36724.81637591795, 37553.43669845009, 38075.61924380721, 40802.1839563213, 43810.78094609507, 56660.0, 57503.42496574981, 58064.709676453036, 58471.57493019257, 59326.40673593209, 4827.806887724592, 4884.072026314989, 7306.9770232166475, 7577.393808495417, 7897.407694422826, 11095.72260693489, 12624.0, 12624.495020199089, 12641.683957900757, 12691.238525688488, 10891.836622450512, 10915.290506117077, 10954.616588419367, 11183.105351572018, 11296.209265351346, 10720.195985300978, 10852.782944340912, 10964.725881853017, 11033.172512061788, 11107.833382499108, 10800.513976870903, 10893.564257429614, 10979.0, 11217.55129794799, 11305.43472826339, 7989.520628762293, 8008.439409241297, 8131.349492040741, 8141.185881412049, 8244.876326855221, 10364.740881478023, 10678.519466624177, 10686.358818470917, 10718.785624287315, 11054.22620416563], "value": 8457.655693826233, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1279.36031984008, 1296.9675758106052, 1298.7337595792858, 1307.8299821023265, 1311.4164196932363, 5962.761489540413, 6165.691715414234, 6354.586951848127, 6656.9667151664235, 6704.966475167629, 6288.811335659926, 6511.869762604745, 6528.0, 6690.163729533809, 6717.0, 2045.8158765711082, 2074.408793493855, 2075.2529089527757, 2079.0, 2083.1250874632615, 1976.8616196866153, 1991.5817678287576, 2053.661145910923, 2056.753189617248, 2060.546679730457, 2052.6818343156833, 2073.9274125405614, 2074.4191626344573, 2076.086521930346, 2076.5431605046865, 1984.7022946557988, 1999.780024197337, 2010.447127040061, 2017.9798202018012, 2020.444377796103, 2034.6541088014924, 2056.321413933413, 2057.4856285928518, 2071.5856828634182, 2093.9162433502643, 6481.83795405114, 6516.478681705452, 6663.267040625527, 6685.93314066858, 6703.9329606703795, 4085.0, 4175.06061136245, 4177.561356057631, 4187.120704651997, 4188.497380314351, 2537.847729136239, 2788.665360156794, 2820.4077143799623, 2826.222788733094, 2831.5327970884778, 1105.0883021507289, 1108.7228192951761, 1126.048489026771, 1143.7998350288667, 1154.7805916875766, 8338.916610833874, 8377.162283771635, 8397.496150230945, 8423.70517031901, 8474.983002039795, 3551.3430015446706, 3551.4317709166407, 3636.8727094551564, 3679.411294192916, 3734.215814678948, 6691.297413771581, 6726.159230096238, 6730.32696730323, 6742.292059333798, 6767.086443330186, 4029.992501874531, 4042.6765858731233, 4082.714210005271, 4088.2436749201493, 4147.460830092069, 3825.0, 3909.980450097731, 3963.900902477461, 3966.7619942803526, 3979.3633018716864, 3092.4537731134433, 3096.2259435141214, 3149.2599239178776, 3195.2331440454122, 3272.6236482804306, 890.7505898348472, 910.1490106750209, 915.8809354783835, 966.0387914025449, 977.7751117243074, 841.6759547574228, 841.8526757817358, 843.7510934274404, 865.7099871543104, 867.3624885708999, 4578.725276483422, 4622.884427889329, 4649.721016739007, 4657.4876763555985, 4697.389339385858, 881.6164968238836, 898.9056149104381, 899.6041741633791, 899.6671231644334, 900.2842740021698, 3263.608366995928, 3282.031800618823, 3312.403767321905, 3372.662733726657, 3427.691507764313, 7503.962480187564, 7812.648430820626, 7814.0, 7820.804479887935, 7837.3338266246865, 7708.344790692854, 7716.2669546393, 7722.189170137167, 7729.536227826348, 7736.806579835549, 6207.6585787781205, 6310.9368906311265, 6320.241571011508, 6339.587926784744, 6400.23197216337, 4603.792829322621, 4626.236670949255, 4685.1332503486965, 4715.717056976592, 4762.714237145644, 7062.752803651848, 7078.716851326095, 7105.0408194893025, 7140.642967851691, 7226.7109315626785, 7161.928380716335, 7176.425885929218, 7298.197198308076, 7303.30618591233, 7308.04995350601, 5323.574114070788, 5385.138377859524, 5388.46115388458, 5391.32608423947, 5401.891962160814, 6048.334683184934, 6074.0, 6113.602615829956, 6118.785842495491, 6159.538034647329, 5739.139129130664, 5766.682832444256, 5785.39253378406, 5787.276590426197, 5813.912791308049, 5698.1737648041635, 5778.191053252632, 5780.739866705924, 5791.710414479344, 5866.149408335853, 5168.819091331786, 5258.553022992935, 5259.053370393366, 5266.868328291824, 5267.789288428573, 4106.979465102655, 4130.855420060284, 4143.440635514287, 4194.182134483746, 4242.045539753531, 4031.209362808787, 4105.548389677193, 4122.113745544722, 4160.687948403943, 4227.7040607157205], "value": 3649.163296566736, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.1165699240022, 346.9531613232213, 353.4397979202963, 353.48567833801815, 357.8962100990714, 4821.541953514419, 4914.778834952427, 5049.621278404121, 5072.2391641253835, 5078.746062696864, 4772.80908763649, 4909.705417674933, 4942.5304596063315, 4970.403551573816, 4981.153203955328, 3995.240904228202, 4008.418779277003, 4011.679065674739, 4032.43545903573, 4036.313826649462, 3897.707671924603, 3979.721419500622, 3994.001499625094, 4004.3993400989793, 4005.879823605282, 3955.624215699504, 3957.5844536323702, 3980.8606698765548, 3993.7803420811842, 4000.179963107556, 3972.192652343191, 3979.86070487533, 3980.960190398117, 3983.980080099581, 4010.6590939770153, 3559.0, 3559.288142371536, 3563.3786627084614, 3590.389633762267, 3593.730470214718, 4657.650676199299, 4869.488703686097, 4872.7585310757095, 4906.681065730716, 4919.434265059493, 4570.131674981776, 4574.089153773509, 4579.885677739136, 4594.977025114887, 4609.907801843944, 5205.531502164823, 5207.869803254911, 5214.895702085937, 5234.241035049935, 5236.188390799432, 3408.1820363112924, 3592.910177245564, 3859.591249194052, 3889.105505733669, 3896.980515097435, 5465.617406781527, 5469.288992430958, 5484.0, 5488.835334939959, 5501.669899806025, 3757.436384542286, 3764.3976963686227, 3777.6788972937607, 3790.696744260508, 3807.7144214184045, 3780.319542482325, 3791.5071040765074, 3797.981010094987, 3810.256999884996, 3810.923781524354, 4170.979145104255, 4338.370936214231, 4382.364557139197, 4386.890327741832, 4424.203643344164, 5270.1040823060175, 5288.497592728685, 5297.973510132425, 5302.2311764793885, 5306.416294207634, 1220.231254309797, 1239.3369547292336, 1249.5688987299368, 1251.5494422008069, 1258.3205069262497, 860.6213266162869, 864.7492227254025, 866.0906048649019, 871.9084496127942, 878.0955615715823, 4399.736015838996, 4410.0, 4419.011444849831, 4420.342371610646, 4450.577195166454, 5118.744062796845, 5142.537171654569, 5149.356330458692, 5165.044466773659, 5172.508611681884, 4326.459192600925, 4607.7004994675235, 4619.353290539327, 4621.168189725814, 4637.5130611286, 2772.431651511435, 2803.4393121375806, 2808.817426867247, 2811.479876222905, 2824.943501129966, 4641.466231383434, 4869.806897310182, 4916.213405855046, 4943.90112197754, 4951.925721114186, 5290.931259869267, 5338.599605029638, 5350.91973620396, 5355.598330125256, 5378.327709036371, 4880.438749543848, 4910.238912968495, 4911.803527858917, 4922.680025798383, 4930.890549626305, 5067.366579177603, 5177.275181474672, 5197.596648904851, 5202.947970520247, 5302.310699609026, 5100.821471248489, 5175.430702622783, 5193.610479213999, 5199.4020687621405, 5234.52889239955, 4918.754062296799, 4926.211806111005, 4949.653524253267, 4954.727489988085, 4955.40535135786, 3562.4300111982993, 3622.9818850905576, 3639.398664587573, 3650.762700424464, 3653.4337177737493, 5356.196570514454, 5381.19282107687, 5381.67709937405, 5386.767939236427, 5395.838124856261, 5191.714455704972, 5201.895962080662, 5241.0, 5267.367915850123, 5326.147816349366, 4959.900801984012, 5111.539961403343, 5230.660007099526, 5264.52619264268, 5269.947300526946, 4922.310876477224, 5015.749212539431, 5044.571211446922, 5090.440051594395, 5095.719735414587, 5199.506046925536, 5206.869828254324, 5213.661112027706, 5221.817236396708, 5257.553107985864, 5095.464976177596, 5115.82577404609, 5122.897542049063, 5123.462036486116, 5123.6157288202785], "value": 3920.8627100456674, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [668.7258224128109, 675.0818886314611, 732.1676932247166, 756.5082696247439, 779.9376049916008, 12183.695407614814, 13373.465061397557, 13375.7324853503, 13448.68812040819, 13475.191488510673, 11371.488283027264, 11512.942435287812, 11674.124440666941, 11681.941590292057, 11902.583409580666, 791.4973991515401, 794.4835856693167, 822.7655118291289, 833.0253603284172, 834.0783434305097, 834.1950018232404, 836.4730219961447, 838.9748307550752, 840.470503582742, 841.0202114536557, 856.1866227084264, 856.5845564901018, 856.6230858422274, 858.5020688000976, 860.2300940658107, 853.0445900591316, 853.5689476814231, 855.7518319687283, 855.8288342331527, 856.7900864288258, 624.4348864277836, 624.44736408279, 624.725120946782, 625.0093601641404, 625.3746253746253, 14156.858431415658, 14411.0, 14577.344019519147, 14730.042547234396, 14741.336639851232, 13270.86729132706, 13783.729961166942, 13788.712990455695, 13833.170009799444, 13884.0, 10697.09074728649, 10722.356658600509, 10758.623448179354, 10883.891161088446, 10970.451477426177, 3285.720713739335, 3319.618243901934, 3341.231516751161, 3378.594568651753, 3450.1719587299117, 70737.29262707359, 71953.6402317985, 73363.26636733618, 74092.0, 74262.05903527705, 9867.30928834989, 10543.683689489328, 10630.468476576294, 11040.33757974524, 11101.777964440666, 20242.392728218176, 20268.0, 20411.387658370273, 20427.0, 20492.487687807923, 6387.648679322682, 6517.348265173539, 6670.032845237511, 6683.933160668331, 6739.123913891261, 3491.965080349215, 3592.1378869071236, 3595.442706380515, 3598.47822065799, 3674.4488326750666, 2660.401409682806, 2802.677692065398, 2805.438912217565, 2821.8871245150376, 2837.177218606581, 535.154455959583, 537.4249552978354, 539.3581637850945, 540.4406439335269, 551.8013515134548, 638.2946843737695, 652.1815122021927, 652.4584594786317, 654.0646874968841, 654.6792071884743, 8683.175098365646, 8762.824743505222, 9393.483358415353, 9409.576569054409, 9960.501974901226, 533.6717918480184, 534.8315280686571, 541.6587549843573, 544.6106034185576, 552.9419410961791, 4273.047964514338, 4314.849652124586, 4519.796609152596, 4525.162844873709, 4651.744154071558, 61701.38298617046, 66288.6685566569, 66594.0, 66879.66560167167, 67005.66497167484, 59843.10235346473, 60565.394346056855, 61108.69445652832, 61441.0, 61884.690576546825, 53179.468205318226, 53573.196402054, 53768.0, 55596.16605750998, 56339.0, 8379.49723016621, 8721.65113395457, 8753.0, 8794.252488538546, 8940.240079593308, 37080.25839483141, 38498.6150138495, 39263.0, 39412.211755764154, 39437.0, 46822.53177468182, 48214.75892620515, 48477.0, 48669.0, 49307.7534612339, 10705.825213849044, 10783.622573210214, 11026.0, 11028.779424411627, 11202.271852329572, 11652.30086194831, 11674.299542027506, 11801.940990294994, 11826.881731182579, 12714.364281786058, 10709.839352409565, 10967.890321097006, 11185.384803835866, 11603.883961160618, 11655.0, 11251.0, 11531.365774882463, 11826.82259766087, 11948.820767688318, 12007.519699211934, 10847.891521085005, 11222.831657524981, 11363.204575679623, 11399.943000285277, 11654.76690466169, 9284.814303714023, 9304.627814887599, 9537.856932145885, 9594.66418675343, 9863.654772082942, 8980.955095224483, 9420.0, 9511.286653501153, 9526.380785248937, 9546.809063818546], "value": 6434.322877323425, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 116.0, 116.0, 115.0, 116.0, 116.0, 116.0, 115.0, 115.0, 115.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 131.0, 131.0, 176.0, 126.0, 126.0, 125.0, 124.0, 144.0, 123.0], "value": 136.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 165.0, 173.0, 163.0, 162.0, 161.0, 163.0, 162.0, 162.0], "value": 164.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 115.0, 81.0, 79.0, 77.0, 80.0, 92.0, 78.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 86.0, 103.0, 85.0, 89.0, 86.0, 100.0, 86.0, 86.0, 115.0], "value": 92.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 120.0, 117.0, 118.0, 118.0, 123.0, 117.0, 119.0, 119.0, 117.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 152.0, 150.0, 151.0, 152.0, 150.0, 151.0, 150.0, 150.0, 151.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 96.0, 96.0, 97.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0], "value": 96.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 67.0, 67.0, 68.0, 67.0, 68.0, 66.0, 73.0], "value": 67.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 67.0, 67.0, 66.0, 66.0, 66.0, 67.0, 67.0], "value": 66.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 92.0, 91.0, 84.0, 89.0, 86.0, 92.0, 90.0, 85.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 147.0, 137.0, 136.0, 133.0, 144.0, 134.0, 143.0, 190.0, 132.0], "value": 143.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 187.0, 176.0, 183.0, 179.0, 179.0, 183.0, 175.0, 176.0], "value": 180.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 79.0, 71.0, 76.0, 68.0, 70.0, 69.0, 68.0, 67.0, 70.0], "value": 70.7, "unit": "score"}]}]} 09:13:46 INFO - Return code: 0 09:13:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:13:46 ERROR - # TBPL SUCCESS # 09:13:46 INFO - Running post-action listener: _resource_record_post_action 09:13:46 INFO - [mozharness: 2017-01-07 17:13:46.920236Z] Finished run-tests step (success) 09:13:46 INFO - Running post-run listener: _resource_record_post_run 09:13:46 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 4096; Write bytes: 407326720; Read time: 12; Write time: 224072 09:13:46 INFO - TinderboxPrint: CPU usage
13.5% 09:13:46 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:13:46 INFO - TinderboxPrint: I/O write bytes / time
407,326,720 / 224,072 09:13:46 INFO - TinderboxPrint: CPU idle
8,288.5 (86.5%) 09:13:46 INFO - TinderboxPrint: CPU user
1,233.9 (12.9%) 09:13:46 INFO - TinderboxPrint: Swap in / out
0 / 0 09:13:46 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 110481408; Read time: 0; Write time: 69344 09:13:47 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 4096; Write bytes: 296501248; Read time: 12; Write time: 154696 09:13:47 INFO - Running post-run listener: _upload_blobber_files 09:13:47 INFO - Blob upload gear active. 09:13:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:13:47 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 09:13:47 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'] 09:13:47 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 09:13:47 INFO - (blobuploader) - INFO - Open directory for files ... 09:13:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:13:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:13:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:51 INFO - (blobuploader) - INFO - Done attempting. 09:13:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:13:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:52 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:13:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:52 INFO - (blobuploader) - INFO - Done attempting. 09:13:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:13:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:13:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:52 INFO - (blobuploader) - INFO - Done attempting. 09:13:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:13:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:13:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:13:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:13:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:13:53 INFO - (blobuploader) - INFO - Done attempting. 09:13:53 INFO - (blobuploader) - INFO - Iteration through files over. 09:13:53 INFO - Return code: 0 09:13:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:13:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:13:53 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe047d7624e429ca41a7e4ae37145ceae8e59960a1ccc21d117f03f4762feebe68cc1993127f17002a9317dfe592b670e0129620555595f20ecdb73dfff8e81c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/95383111febd195875de5a969551d2c2094ab4115d1458a9fabd9745b785f2ac948875ede8b48d2f6a5c14f69dfec1c5f512823f06ff8274ea0561e62dbca4ca", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d2a287c8090b33e447497a795f13ce6a861209ee1f0b186d669936eb5731800d384b35c7fb3eaddf5866a0f1aa754aa570f8df07ec807e66f86e53ab0e72e98", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a53e32230c77804ec9370f9d2a83d74a1c0a74612dd41907c1e7b05c8628ec5884a33217af2e3fd5537d65d48ff5de4e662cc0067fe38cde1c15264d4aac86a5"} 09:13:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:13:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:13:53 INFO - Contents: 09:13:53 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe047d7624e429ca41a7e4ae37145ceae8e59960a1ccc21d117f03f4762feebe68cc1993127f17002a9317dfe592b670e0129620555595f20ecdb73dfff8e81c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/95383111febd195875de5a969551d2c2094ab4115d1458a9fabd9745b785f2ac948875ede8b48d2f6a5c14f69dfec1c5f512823f06ff8274ea0561e62dbca4ca", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d2a287c8090b33e447497a795f13ce6a861209ee1f0b186d669936eb5731800d384b35c7fb3eaddf5866a0f1aa754aa570f8df07ec807e66f86e53ab0e72e98", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a53e32230c77804ec9370f9d2a83d74a1c0a74612dd41907c1e7b05c8628ec5884a33217af2e3fd5537d65d48ff5de4e662cc0067fe38cde1c15264d4aac86a5"} 09:13:53 INFO - Running post-run listener: copy_logs_to_upload_dir 09:13:53 INFO - Copying logs to upload dir... 09:13:53 INFO - mkdir: /builds/slave/test/build/upload/logs 09:13:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.506855 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-01-07 09:13:53.120198) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-07 09:13:53.123893) ========= 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=8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628 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/fe047d7624e429ca41a7e4ae37145ceae8e59960a1ccc21d117f03f4762feebe68cc1993127f17002a9317dfe592b670e0129620555595f20ecdb73dfff8e81c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/95383111febd195875de5a969551d2c2094ab4115d1458a9fabd9745b785f2ac948875ede8b48d2f6a5c14f69dfec1c5f512823f06ff8274ea0561e62dbca4ca", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d2a287c8090b33e447497a795f13ce6a861209ee1f0b186d669936eb5731800d384b35c7fb3eaddf5866a0f1aa754aa570f8df07ec807e66f86e53ab0e72e98", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a53e32230c77804ec9370f9d2a83d74a1c0a74612dd41907c1e7b05c8628ec5884a33217af2e3fd5537d65d48ff5de4e662cc0067fe38cde1c15264d4aac86a5"} build_url:https://queue.taskcluster.net/v1/task/FAfCRL6cTjaWvpEhSzvceQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011571 build_url: 'https://queue.taskcluster.net/v1/task/FAfCRL6cTjaWvpEhSzvceQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/fe047d7624e429ca41a7e4ae37145ceae8e59960a1ccc21d117f03f4762feebe68cc1993127f17002a9317dfe592b670e0129620555595f20ecdb73dfff8e81c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/95383111febd195875de5a969551d2c2094ab4115d1458a9fabd9745b785f2ac948875ede8b48d2f6a5c14f69dfec1c5f512823f06ff8274ea0561e62dbca4ca", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6d2a287c8090b33e447497a795f13ce6a861209ee1f0b186d669936eb5731800d384b35c7fb3eaddf5866a0f1aa754aa570f8df07ec807e66f86e53ab0e72e98", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a53e32230c77804ec9370f9d2a83d74a1c0a74612dd41907c1e7b05c8628ec5884a33217af2e3fd5537d65d48ff5de4e662cc0067fe38cde1c15264d4aac86a5"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-07 09:13:53.148954) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 09:13:53.149276) ========= 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=8887e36bb8e381bfd44124ac000001a8-1483795591.36850-184553628 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004441 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 09:13:53.233479) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-07 09:13:53.233797) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-07 09:13:53.234146) ========= ========= Total master_lag: 0.18 =========