builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-054 starttime: 1483585496.19 results: success (0) revision: f13abb8ba9f366c9f32a3146245adf642528becd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-04 19:04:56.192673) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-04 19:04:56.193088) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-04 19:04:56.193561) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-04 19:04:56.219680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 19:04:56.219972) ========= 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=cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-04 19:04:56-- 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% 50.8M=0s 2017-01-04 19:04:56 (50.8 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.121893 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 19:04:56.359843) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 19:04:56.360149) ========= 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=cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019780 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 19:04:56.410604) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-04 19:04:56.410913) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f13abb8ba9f366c9f32a3146245adf642528becd --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 f13abb8ba9f366c9f32a3146245adf642528becd --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=cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-04 19:04:57,042 truncating revision to first 12 chars 2017-01-04 19:04:57,042 Setting DEBUG logging. 2017-01-04 19:04:57,042 attempt 1/10 2017-01-04 19:04:57,042 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f13abb8ba9f3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-04 19:04:58,374 unpacking tar archive at: mozilla-central-f13abb8ba9f3/testing/mozharness/ program finished with exit code 0 elapsedTime=1.612562 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-04 19:04:58.036786) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-04 19:04:58.037108) ========= script_repo_revision: f13abb8ba9f366c9f32a3146245adf642528becd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-04 19:04:58.037558) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-04 19:04:58.037843) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-04 19:04:58.046384) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-01-04 19:04:58.046685) ========= /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=cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:04:58 INFO - MultiFileLogger online at 20170104 19:04:58 in /builds/slave/test 19:04:58 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 19:04:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:04:58 INFO - {'append_to_log': False, 19:04:58 INFO - 'base_work_dir': '/builds/slave/test', 19:04:58 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 19:04:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:04:58 INFO - 'branch': 'Firefox-Non-PGO', 19:04:58 INFO - 'buildbot_json_path': 'buildprops.json', 19:04:58 INFO - 'config_files': ('talos/linux_config.py',), 19:04:58 INFO - 'default_actions': ('clobber', 19:04:58 INFO - 'read-buildbot-config', 19:04:58 INFO - 'download-and-extract', 19:04:58 INFO - 'populate-webroot', 19:04:58 INFO - 'create-virtualenv', 19:04:58 INFO - 'install', 19:04:58 INFO - 'run-tests'), 19:04:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:04:58 INFO - 'download_minidump_stackwalk': True, 19:04:58 INFO - 'download_symbols': 'ondemand', 19:04:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:04:58 INFO - 'tooltool.py': '/tools/tooltool.py', 19:04:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:04:58 INFO - '/tools/misc-python/virtualenv.py')}, 19:04:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:04:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:04:58 INFO - 'installer_path': 'installer.exe', 19:04:58 INFO - 'log_level': 'info', 19:04:58 INFO - 'log_name': 'talos', 19:04:58 INFO - 'log_to_console': True, 19:04:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:04:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:04:58 INFO - 'opt_config_files': (), 19:04:58 INFO - 'pip_index': False, 19:04:58 INFO - 'sps_profile': False, 19:04:58 INFO - 'sps_profile_interval': 0, 19:04:58 INFO - 'suite': 'dromaeojs-e10s', 19:04:58 INFO - 'system_bits': '32', 19:04:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:04:58 INFO - 'title': 'talos-linux64-ix-054', 19:04:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:04:58 INFO - 'use_talos_json': True, 19:04:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:04:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:04:58 INFO - 'work_dir': 'build'} 19:04:58 INFO - [mozharness: 2017-01-05 03:04:58.784650Z] Running clobber step. 19:04:58 INFO - Running pre-action listener: _resource_record_pre_action 19:04:58 INFO - Running main action method: clobber 19:04:58 INFO - rmtree: /builds/slave/test/build 19:04:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:04:59 INFO - Running post-action listener: _resource_record_post_action 19:04:59 INFO - [mozharness: 2017-01-05 03:04:59.246840Z] Finished clobber step (success) 19:04:59 INFO - [mozharness: 2017-01-05 03:04:59.246940Z] Running read-buildbot-config step. 19:04:59 INFO - Running pre-action listener: _resource_record_pre_action 19:04:59 INFO - Running main action method: read_buildbot_config 19:04:59 INFO - Using buildbot properties: 19:04:59 INFO - { 19:04:59 INFO - "project": "", 19:04:59 INFO - "product": "firefox", 19:04:59 INFO - "who": "philringnalda@gmail.com", 19:04:59 INFO - "installer_path": "public/build/target.tar.bz2", 19:04:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:04:59 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 19:04:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 19:04:59 INFO - "stage_platform": "linux64", 19:04:59 INFO - "basedir": "/builds/slave/test", 19:04:59 INFO - "buildnumber": 599, 19:04:59 INFO - "platform": "ubuntu64_hw", 19:04:59 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:04:59 INFO - "slavebuilddir": "test", 19:04:59 INFO - "taskId": "H11_wA6nR_W4sJYdJVpMng", 19:04:59 INFO - "branch": "mozilla-central", 19:04:59 INFO - "script_repo_revision": "production", 19:04:59 INFO - "revision": "f13abb8ba9f366c9f32a3146245adf642528becd", 19:04:59 INFO - "slavename": "talos-linux64-ix-054", 19:04:59 INFO - "repo_path": "mozilla-central" 19:04:59 INFO - } 19:04:59 INFO - Finding installer, test and symbols from parent task. 19:04:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H11_wA6nR_W4sJYdJVpMng'}, attempt #1 19:04:59 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/H11_wA6nR_W4sJYdJVpMng'}, attempt #1 19:05:00 INFO - Task dependencies: f5Ky-r_QQvOycseDCgcSlA 19:05:00 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f5Ky-r_QQvOycseDCgcSlA'}, attempt #1 19:05:00 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/f5Ky-r_QQvOycseDCgcSlA/artifacts/public/build/target.tar.bz2 19:05:00 INFO - Set test_url: https://queue.taskcluster.net/v1/task/f5Ky-r_QQvOycseDCgcSlA/artifacts/public/build/test_packages.json 19:05:00 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/f5Ky-r_QQvOycseDCgcSlA/artifacts/public/build/target.crashreporter-symbols.zip 19:05:00 INFO - Running post-action listener: _resource_record_post_action 19:05:00 INFO - [mozharness: 2017-01-05 03:05:00.634394Z] Finished read-buildbot-config step (success) 19:05:00 INFO - [mozharness: 2017-01-05 03:05:00.634610Z] Running download-and-extract step. 19:05:00 INFO - Running pre-action listener: _resource_record_pre_action 19:05:00 INFO - Running main action method: download_and_extract 19:05:00 INFO - mkdir: /builds/slave/test/build/tests 19:05:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:00 INFO - trying https://queue.taskcluster.net/v1/task/f5Ky-r_QQvOycseDCgcSlA/artifacts/public/build/target.test_packages.json 19:05:00 INFO - Downloading https://queue.taskcluster.net/v1/task/f5Ky-r_QQvOycseDCgcSlA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 19:05:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f5Ky-r_QQvOycseDCgcSlA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 19:05:01 INFO - Downloaded 896 bytes. 19:05:01 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 19:05:01 INFO - Using the following test package requirements: 19:05:01 INFO - {u'common': [u'target.common.tests.zip'], 19:05:01 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 19:05:01 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 19:05:01 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 19:05:01 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 19:05:01 INFO - u'mozbase': [u'target.common.tests.zip'], 19:05:01 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 19:05:01 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 19:05:01 INFO - u'web-platform': [u'target.common.tests.zip', 19:05:01 INFO - u'target.web-platform.tests.zip'], 19:05:01 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 19:05:01 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 19:05:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f5Ky-r_QQvOycseDCgcSlA/artifacts/public/build/target.common.tests.zip 19:05:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f5Ky-r_QQvOycseDCgcSlA/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:05:01 INFO - Fetch https://queue.taskcluster.net/v1/task/f5Ky-r_QQvOycseDCgcSlA/artifacts/public/build/target.common.tests.zip into memory 19:05:01 INFO - Expected file size: 20244966 19:05:01 INFO - Obtained file size: 20244966 19:05:05 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 19:05:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f5Ky-r_QQvOycseDCgcSlA/artifacts/public/build/target.common.tests.zip 19:05:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f5Ky-r_QQvOycseDCgcSlA/artifacts/public/build/target.common.tests.zip'}, attempt #1 19:05:05 INFO - Fetch https://queue.taskcluster.net/v1/task/f5Ky-r_QQvOycseDCgcSlA/artifacts/public/build/target.common.tests.zip into memory 19:05:06 INFO - Expected file size: 20244966 19:05:06 INFO - Obtained file size: 20244966 19:05:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/f5Ky-r_QQvOycseDCgcSlA/artifacts/public/build/target.talos.tests.zip 19:05:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/f5Ky-r_QQvOycseDCgcSlA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 19:05:11 INFO - Fetch https://queue.taskcluster.net/v1/task/f5Ky-r_QQvOycseDCgcSlA/artifacts/public/build/target.talos.tests.zip into memory 19:05:11 INFO - Expected file size: 14403730 19:05:11 INFO - Obtained file size: 14403730 19:05:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:12 INFO - trying https://queue.taskcluster.net/v1/task/f5Ky-r_QQvOycseDCgcSlA/artifacts/public/build/target.tar.bz2 19:05:12 INFO - Downloading https://queue.taskcluster.net/v1/task/f5Ky-r_QQvOycseDCgcSlA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 19:05:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/f5Ky-r_QQvOycseDCgcSlA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 19:05:13 INFO - Downloaded 55759787 bytes. 19:05:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/f5Ky-r_QQvOycseDCgcSlA/artifacts/public/build/target.tar.bz2 19:05:13 INFO - mkdir: /builds/slave/test/properties 19:05:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:05:13 INFO - Writing to file /builds/slave/test/properties/build_url 19:05:13 INFO - Contents: 19:05:13 INFO - build_url:https://queue.taskcluster.net/v1/task/f5Ky-r_QQvOycseDCgcSlA/artifacts/public/build/target.tar.bz2 19:05:13 INFO - Running post-action listener: _resource_record_post_action 19:05:13 INFO - Running post-action listener: set_extra_try_arguments 19:05:13 INFO - [mozharness: 2017-01-05 03:05:13.260993Z] Finished download-and-extract step (success) 19:05:13 INFO - [mozharness: 2017-01-05 03:05:13.261090Z] Running populate-webroot step. 19:05:13 INFO - Running pre-action listener: _resource_record_pre_action 19:05:13 INFO - Running main action method: populate_webroot 19:05:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:05:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:05:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:05:13 INFO - '--tppagecycles', 19:05:13 INFO - '7'], 19:05:13 INFO - 'tests': ['tsvgm']}}, 19:05:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:05:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:05:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:05:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:05:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:05:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:05:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:05:13 INFO - 'talos_options': ['--disable-e10s'], 19:05:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:05:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:05:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:05:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:05:13 INFO - 'talos_options': ['--disable-e10s'], 19:05:13 INFO - 'tests': ['damp', 'tps']}, 19:05:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:05:13 INFO - 'tests': ['damp', 'tps']}, 19:05:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:05:13 INFO - 'tests': ['dromaeo_dom']}, 19:05:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:05:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:05:13 INFO - 'tests': ['basic_compositor_video']}, 19:05:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:05:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:05:13 INFO - 'tests': ['a11yr', 19:05:13 INFO - 'ts_paint', 19:05:13 INFO - 'tpaint', 19:05:13 INFO - 'sessionrestore', 19:05:13 INFO - 'sessionrestore_no_auto_restore', 19:05:13 INFO - 'tabpaint']}, 19:05:13 INFO - 'other-e10s': {'tests': ['a11yr', 19:05:13 INFO - 'ts_paint', 19:05:13 INFO - 'tpaint', 19:05:13 INFO - 'sessionrestore', 19:05:13 INFO - 'sessionrestore_no_auto_restore', 19:05:13 INFO - 'tabpaint']}, 19:05:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:05:13 INFO - 'ts_paint', 19:05:13 INFO - 'tpaint', 19:05:13 INFO - 'sessionrestore', 19:05:13 INFO - 'sessionrestore_no_auto_restore', 19:05:13 INFO - 'tabpaint']}, 19:05:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:05:13 INFO - 'ts_paint', 19:05:13 INFO - 'tpaint', 19:05:13 INFO - 'sessionrestore', 19:05:13 INFO - 'sessionrestore_no_auto_restore', 19:05:13 INFO - 'tabpaint']}, 19:05:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:05:13 INFO - 'tests': ['a11yr', 19:05:13 INFO - 'ts_paint', 19:05:13 INFO - 'tpaint', 19:05:13 INFO - 'sessionrestore', 19:05:13 INFO - 'sessionrestore_no_auto_restore', 19:05:13 INFO - 'tabpaint']}, 19:05:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:05:13 INFO - 'tests': ['a11yr', 19:05:13 INFO - 'ts_paint', 19:05:13 INFO - 'tpaint', 19:05:13 INFO - 'sessionrestore', 19:05:13 INFO - 'sessionrestore_no_auto_restore', 19:05:13 INFO - 'tabpaint']}, 19:05:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:05:13 INFO - 'tests': ['tsvgx', 19:05:13 INFO - 'tsvgr_opacity', 19:05:13 INFO - 'tart', 19:05:13 INFO - 'tscrollx', 19:05:13 INFO - 'cart', 19:05:13 INFO - 'tsvg_static']}, 19:05:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:05:13 INFO - 'tsvgr_opacity', 19:05:13 INFO - 'tart', 19:05:13 INFO - 'tscrollx', 19:05:13 INFO - 'cart', 19:05:13 INFO - 'tsvg_static']}, 19:05:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:05:13 INFO - 'talos_options': ['--disable-e10s'], 19:05:13 INFO - 'tests': ['tp5o']}, 19:05:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:05:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:05:13 INFO - 'talos_options': ['--disable-e10s', 19:05:13 INFO - '--xperf_path', 19:05:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:05:13 INFO - 'tests': ['tp5n']}, 19:05:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:05:13 INFO - 'talos_options': ['--xperf_path', 19:05:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:05:13 INFO - 'tests': ['tp5n']}}, 19:05:13 INFO - 'talos.zip': {'path': '', 19:05:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:05:13 INFO - Running post-action listener: _resource_record_post_action 19:05:13 INFO - [mozharness: 2017-01-05 03:05:13.274269Z] Finished populate-webroot step (success) 19:05:13 INFO - [mozharness: 2017-01-05 03:05:13.274359Z] Running create-virtualenv step. 19:05:13 INFO - Running pre-action listener: _resource_record_pre_action 19:05:13 INFO - Running main action method: create_virtualenv 19:05:13 INFO - Creating virtualenv /builds/slave/test/build/venv 19:05:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:05:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:05:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:05:13 INFO - Using real prefix '/usr' 19:05:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:05:13 INFO - Installing distribute.............................................................................................................................................................................................done. 19:05:15 INFO - Installing pip.................done. 19:05:15 INFO - Return code: 0 19:05:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:05:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:05:16 INFO - Reading from file tmpfile_stdout 19:05:16 INFO - Output received: 19:05:16 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 19:05:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:16 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 0x1f5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cf480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cc820>, '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 0x22cd520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cd9b0>, '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': 'cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:05:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:05:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:05:16 INFO - Using env: {'DISPLAY': ':0', 19:05:16 INFO - 'HOME': '/home/cltbld', 19:05:16 INFO - 'LANG': 'en_US.UTF-8', 19:05:16 INFO - 'LANGUAGE': 'en_US:en', 19:05:16 INFO - 'LOGNAME': 'cltbld', 19:05:16 INFO - 'MAIL': '/var/mail/cltbld', 19:05:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:16 INFO - 'MOZ_NO_REMOTE': '1', 19:05:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:16 INFO - 'NO_EM_RESTART': '1', 19:05:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:16 INFO - 'PWD': '/builds/slave/test', 19:05:16 INFO - 'SHELL': '/bin/bash', 19:05:16 INFO - 'SHLVL': '1', 19:05:16 INFO - 'TERM': 'linux', 19:05:16 INFO - 'TMOUT': '86400', 19:05:16 INFO - 'USER': 'cltbld', 19:05:16 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077', 19:05:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:16 INFO - '_': '/tools/buildbot/bin/python'} 19:05:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:05:16 INFO - Cleaning up... 19:05:16 INFO - Return code: 0 19:05:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:16 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 0x1f5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cf480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cc820>, '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 0x22cd520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cd9b0>, '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': 'cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:05:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 19:05:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 19:05:16 INFO - Using env: {'DISPLAY': ':0', 19:05:16 INFO - 'HOME': '/home/cltbld', 19:05:16 INFO - 'LANG': 'en_US.UTF-8', 19:05:16 INFO - 'LANGUAGE': 'en_US:en', 19:05:16 INFO - 'LOGNAME': 'cltbld', 19:05:16 INFO - 'MAIL': '/var/mail/cltbld', 19:05:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:16 INFO - 'MOZ_NO_REMOTE': '1', 19:05:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:16 INFO - 'NO_EM_RESTART': '1', 19:05:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:16 INFO - 'PWD': '/builds/slave/test', 19:05:16 INFO - 'SHELL': '/bin/bash', 19:05:16 INFO - 'SHLVL': '1', 19:05:16 INFO - 'TERM': 'linux', 19:05:16 INFO - 'TMOUT': '86400', 19:05:16 INFO - 'USER': 'cltbld', 19:05:16 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077', 19:05:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:16 INFO - '_': '/tools/buildbot/bin/python'} 19:05:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:16 INFO - Downloading/unpacking psutil>=3.1.1 19:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:05:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:05:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:05:18 INFO - Installing collected packages: psutil 19:05:18 INFO - Running setup.py install for psutil 19:05:18 INFO - building 'psutil._psutil_linux' extension 19:05:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:05:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:05:18 INFO - building 'psutil._psutil_posix' extension 19:05:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 19:05:19 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 19:05:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:05:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:05:19 INFO - Successfully installed psutil 19:05:19 INFO - Cleaning up... 19:05:19 INFO - Return code: 0 19:05:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:19 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 0x1f5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cf480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cc820>, '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 0x22cd520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cd9b0>, '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': 'cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:05:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 19:05:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 19:05:19 INFO - Using env: {'DISPLAY': ':0', 19:05:19 INFO - 'HOME': '/home/cltbld', 19:05:19 INFO - 'LANG': 'en_US.UTF-8', 19:05:19 INFO - 'LANGUAGE': 'en_US:en', 19:05:19 INFO - 'LOGNAME': 'cltbld', 19:05:19 INFO - 'MAIL': '/var/mail/cltbld', 19:05:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:19 INFO - 'MOZ_NO_REMOTE': '1', 19:05:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:19 INFO - 'NO_EM_RESTART': '1', 19:05:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:19 INFO - 'PWD': '/builds/slave/test', 19:05:19 INFO - 'SHELL': '/bin/bash', 19:05:19 INFO - 'SHLVL': '1', 19:05:19 INFO - 'TERM': 'linux', 19:05:19 INFO - 'TMOUT': '86400', 19:05:19 INFO - 'USER': 'cltbld', 19:05:19 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077', 19:05:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:19 INFO - '_': '/tools/buildbot/bin/python'} 19:05:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:21 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:05:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:05:21 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:05:21 INFO - Installing collected packages: mozsystemmonitor 19:05:21 INFO - Running setup.py install for mozsystemmonitor 19:05:21 INFO - Successfully installed mozsystemmonitor 19:05:21 INFO - Cleaning up... 19:05:21 INFO - Return code: 0 19:05:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:05: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')]} 19:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05: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')]} 19:05:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:21 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 0x1f5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cf480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cc820>, '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 0x22cd520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cd9b0>, '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': 'cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:05:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 19:05:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 19:05:21 INFO - Using env: {'DISPLAY': ':0', 19:05:21 INFO - 'HOME': '/home/cltbld', 19:05:21 INFO - 'LANG': 'en_US.UTF-8', 19:05:21 INFO - 'LANGUAGE': 'en_US:en', 19:05:21 INFO - 'LOGNAME': 'cltbld', 19:05:21 INFO - 'MAIL': '/var/mail/cltbld', 19:05:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:21 INFO - 'MOZ_NO_REMOTE': '1', 19:05:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:21 INFO - 'NO_EM_RESTART': '1', 19:05:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:21 INFO - 'PWD': '/builds/slave/test', 19:05:21 INFO - 'SHELL': '/bin/bash', 19:05:21 INFO - 'SHLVL': '1', 19:05:21 INFO - 'TERM': 'linux', 19:05:21 INFO - 'TMOUT': '86400', 19:05:21 INFO - 'USER': 'cltbld', 19:05:21 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077', 19:05:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:21 INFO - '_': '/tools/buildbot/bin/python'} 19:05:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:21 INFO - Downloading/unpacking jsonschema==2.5.1 19:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:05:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:24 INFO - Downloading functools32-3.2.3-2.tar.gz 19:05:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:05:24 INFO - warning: no files found matching '*.txt' 19:05:24 INFO - no previously-included directories found matching 'build' 19:05:24 INFO - no previously-included directories found matching 'dist' 19:05:24 INFO - no previously-included directories found matching '.git*' 19:05:24 INFO - Installing collected packages: jsonschema, functools32 19:05:24 INFO - Running setup.py install for functools32 19:05:24 INFO - warning: no files found matching '*.txt' 19:05:24 INFO - no previously-included directories found matching 'build' 19:05:24 INFO - no previously-included directories found matching 'dist' 19:05:24 INFO - no previously-included directories found matching '.git*' 19:05:24 INFO - Successfully installed jsonschema functools32 19:05:24 INFO - Cleaning up... 19:05:24 INFO - Return code: 0 19:05:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:24 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 0x1f5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cf480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cc820>, '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 0x22cd520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cd9b0>, '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': 'cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:05:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 19:05:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 19:05:24 INFO - Using env: {'DISPLAY': ':0', 19:05:24 INFO - 'HOME': '/home/cltbld', 19:05:24 INFO - 'LANG': 'en_US.UTF-8', 19:05:24 INFO - 'LANGUAGE': 'en_US:en', 19:05:24 INFO - 'LOGNAME': 'cltbld', 19:05:24 INFO - 'MAIL': '/var/mail/cltbld', 19:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:24 INFO - 'MOZ_NO_REMOTE': '1', 19:05:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:24 INFO - 'NO_EM_RESTART': '1', 19:05:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:24 INFO - 'PWD': '/builds/slave/test', 19:05:24 INFO - 'SHELL': '/bin/bash', 19:05:24 INFO - 'SHLVL': '1', 19:05:24 INFO - 'TERM': 'linux', 19:05:24 INFO - 'TMOUT': '86400', 19:05:24 INFO - 'USER': 'cltbld', 19:05:24 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077', 19:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:24 INFO - '_': '/tools/buildbot/bin/python'} 19:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:05:24 INFO - Cleaning up... 19:05:24 INFO - Return code: 0 19:05:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:24 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 0x1f5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cf480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cc820>, '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 0x22cd520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cd9b0>, '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': 'cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:05:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:05:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:05:24 INFO - Using env: {'DISPLAY': ':0', 19:05:24 INFO - 'HOME': '/home/cltbld', 19:05:24 INFO - 'LANG': 'en_US.UTF-8', 19:05:24 INFO - 'LANGUAGE': 'en_US:en', 19:05:24 INFO - 'LOGNAME': 'cltbld', 19:05:24 INFO - 'MAIL': '/var/mail/cltbld', 19:05:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:24 INFO - 'MOZ_NO_REMOTE': '1', 19:05:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:24 INFO - 'NO_EM_RESTART': '1', 19:05:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:24 INFO - 'PWD': '/builds/slave/test', 19:05:24 INFO - 'SHELL': '/bin/bash', 19:05:24 INFO - 'SHLVL': '1', 19:05:24 INFO - 'TERM': 'linux', 19:05:24 INFO - 'TMOUT': '86400', 19:05:24 INFO - 'USER': 'cltbld', 19:05:24 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077', 19:05:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:24 INFO - '_': '/tools/buildbot/bin/python'} 19:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:24 INFO - Downloading/unpacking blobuploader==1.2.4 19:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:26 INFO - Downloading blobuploader-1.2.4.tar.gz 19:05:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:05:26 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05: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 19:05:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:05:27 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:27 INFO - Downloading docopt-0.6.1.tar.gz 19:05:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:05:27 INFO - Installing collected packages: blobuploader, requests, docopt 19:05:27 INFO - Running setup.py install for blobuploader 19:05:27 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:05:27 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:05:27 INFO - Running setup.py install for requests 19:05:28 INFO - Running setup.py install for docopt 19:05:28 INFO - Successfully installed blobuploader requests docopt 19:05:28 INFO - Cleaning up... 19:05:28 INFO - Return code: 0 19:05:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05: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')]} 19:05:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05: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')]} 19:05:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:28 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 0x1f5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cf480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cc820>, '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 0x22cd520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cd9b0>, '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': 'cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:05:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:05:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:05:28 INFO - Using env: {'DISPLAY': ':0', 19:05:28 INFO - 'HOME': '/home/cltbld', 19:05:28 INFO - 'LANG': 'en_US.UTF-8', 19:05:28 INFO - 'LANGUAGE': 'en_US:en', 19:05:28 INFO - 'LOGNAME': 'cltbld', 19:05:28 INFO - 'MAIL': '/var/mail/cltbld', 19:05:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:28 INFO - 'MOZ_NO_REMOTE': '1', 19:05:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:28 INFO - 'NO_EM_RESTART': '1', 19:05:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:28 INFO - 'PWD': '/builds/slave/test', 19:05:28 INFO - 'SHELL': '/bin/bash', 19:05:28 INFO - 'SHLVL': '1', 19:05:28 INFO - 'TERM': 'linux', 19:05:28 INFO - 'TMOUT': '86400', 19:05:28 INFO - 'USER': 'cltbld', 19:05:28 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077', 19:05:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:28 INFO - '_': '/tools/buildbot/bin/python'} 19:05:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:05:28 INFO - Running setup.py (path:/tmp/pip-NXSboM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:05:28 INFO - Running setup.py (path:/tmp/pip-jwZlw5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:05:28 INFO - Running setup.py (path:/tmp/pip-H73cCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:05:28 INFO - Running setup.py (path:/tmp/pip-9bavhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:05:28 INFO - Running setup.py (path:/tmp/pip-9_LTkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:05:28 INFO - Running setup.py (path:/tmp/pip-r8S5Za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:05:28 INFO - Running setup.py (path:/tmp/pip-wYbekS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:05:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:05:28 INFO - Running setup.py (path:/tmp/pip-DlSzfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:05:29 INFO - Running setup.py (path:/tmp/pip-NqjiI7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:05:29 INFO - Running setup.py (path:/tmp/pip-mvW5p0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:05:29 INFO - Running setup.py (path:/tmp/pip-dvBH6K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:05:29 INFO - Running setup.py (path:/tmp/pip-cwgfAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:05:29 INFO - Running setup.py (path:/tmp/pip-iBEWVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:05:29 INFO - Running setup.py (path:/tmp/pip-rSezOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:29 INFO - Running setup.py (path:/tmp/pip-rUmS6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:05:29 INFO - Running setup.py (path:/tmp/pip-M9lbgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:05:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:05:29 INFO - Running setup.py (path:/tmp/pip-dTayLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:05:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:05:29 INFO - Running setup.py install for manifestparser 19:05:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:05:29 INFO - Running setup.py install for mozcrash 19:05:29 INFO - Running setup.py install for mozdebug 19:05:29 INFO - Running setup.py install for mozdevice 19:05:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:05:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:05:30 INFO - Running setup.py install for mozfile 19:05:30 INFO - Running setup.py install for mozhttpd 19:05:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:05:30 INFO - Running setup.py install for mozinfo 19:05:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:05:30 INFO - Running setup.py install for mozInstall 19:05:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:05:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:05:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:05:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:05:30 INFO - Running setup.py install for mozleak 19:05:30 INFO - Running setup.py install for mozlog 19:05:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:05:30 INFO - Running setup.py install for moznetwork 19:05:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:05:30 INFO - Running setup.py install for mozprocess 19:05:30 INFO - Running setup.py install for mozprofile 19:05:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:05:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:05:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:05:31 INFO - Running setup.py install for mozrunner 19:05:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:05:31 INFO - Running setup.py install for mozscreenshot 19:05:31 INFO - Running setup.py install for moztest 19:05:31 INFO - Running setup.py install for mozversion 19:05:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:05:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:05:31 INFO - Cleaning up... 19:05:31 INFO - Return code: 0 19:05:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05: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')]} 19:05:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05: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')]} 19:05:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:31 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 0x1f5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cf480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cc820>, '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 0x22cd520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cd9b0>, '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': 'cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:05:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:05:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:05:31 INFO - Using env: {'DISPLAY': ':0', 19:05:31 INFO - 'HOME': '/home/cltbld', 19:05:31 INFO - 'LANG': 'en_US.UTF-8', 19:05:31 INFO - 'LANGUAGE': 'en_US:en', 19:05:31 INFO - 'LOGNAME': 'cltbld', 19:05:31 INFO - 'MAIL': '/var/mail/cltbld', 19:05:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:31 INFO - 'MOZ_NO_REMOTE': '1', 19:05:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:31 INFO - 'NO_EM_RESTART': '1', 19:05:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:31 INFO - 'PWD': '/builds/slave/test', 19:05:31 INFO - 'SHELL': '/bin/bash', 19:05:31 INFO - 'SHLVL': '1', 19:05:31 INFO - 'TERM': 'linux', 19:05:31 INFO - 'TMOUT': '86400', 19:05:31 INFO - 'USER': 'cltbld', 19:05:31 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077', 19:05:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:31 INFO - '_': '/tools/buildbot/bin/python'} 19:05:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:05:31 INFO - Running setup.py (path:/tmp/pip-rTDuef-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:05:31 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:05:31 INFO - Running setup.py (path:/tmp/pip-2nkoLJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:05:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:05:31 INFO - Running setup.py (path:/tmp/pip-8vN2mX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:05:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:05:31 INFO - Running setup.py (path:/tmp/pip-gWVRwG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:05:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:05:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:05:31 INFO - Running setup.py (path:/tmp/pip-SaAvv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:05:32 INFO - Running setup.py (path:/tmp/pip-djJMJd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:05:32 INFO - Running setup.py (path:/tmp/pip-_7Vkpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:05:32 INFO - Running setup.py (path:/tmp/pip-5loQDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:05:32 INFO - Running setup.py (path:/tmp/pip-alag9X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:05:32 INFO - Running setup.py (path:/tmp/pip-TPcFSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:05:32 INFO - Running setup.py (path:/tmp/pip-8Jx7vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:05:32 INFO - Running setup.py (path:/tmp/pip-R3Rabx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 19:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:05:32 INFO - Running setup.py (path:/tmp/pip-cz1Yfy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 19:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:05:32 INFO - Running setup.py (path:/tmp/pip-4EW5UM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 19:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:32 INFO - Running setup.py (path:/tmp/pip-njGVFF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 19:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:05:32 INFO - Running setup.py (path:/tmp/pip-9CG0CT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:05:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:05:32 INFO - Running setup.py (path:/tmp/pip-eHubGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:05:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:05:32 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:05:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:05:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:05:34 INFO - Downloading blessings-1.6.tar.gz 19:05:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:05:35 INFO - Installing collected packages: blessings 19:05:35 INFO - Running setup.py install for blessings 19:05:35 INFO - Successfully installed blessings 19:05:35 INFO - Cleaning up... 19:05:35 INFO - Return code: 0 19:05:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:05:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:05:35 INFO - Reading from file tmpfile_stdout 19:05:35 INFO - Current package versions: 19:05:35 INFO - argparse == 1.2.1 19:05:35 INFO - blessings == 1.6 19:05:35 INFO - blobuploader == 1.2.4 19:05:35 INFO - docopt == 0.6.1 19:05:35 INFO - functools32 == 3.2.3-2 19:05:35 INFO - jsonschema == 2.5.1 19:05:35 INFO - manifestparser == 1.1 19:05:35 INFO - mozInstall == 1.12 19:05:35 INFO - mozcrash == 1.0 19:05:35 INFO - mozdebug == 0.1 19:05:35 INFO - mozdevice == 0.49 19:05:35 INFO - mozfile == 1.2 19:05:35 INFO - mozhttpd == 0.7 19:05:35 INFO - mozinfo == 0.9 19:05:35 INFO - mozleak == 0.1 19:05:35 INFO - mozlog == 3.4 19:05:35 INFO - moznetwork == 0.27 19:05:35 INFO - mozprocess == 0.23 19:05:35 INFO - mozprofile == 0.28 19:05:35 INFO - mozrunner == 6.13 19:05:35 INFO - mozscreenshot == 0.1 19:05:35 INFO - mozsystemmonitor == 0.3 19:05:35 INFO - moztest == 0.8 19:05:35 INFO - mozversion == 1.4 19:05:35 INFO - psutil == 3.1.1 19:05:35 INFO - requests == 1.2.3 19:05:35 INFO - wsgiref == 0.1.2 19:05:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:35 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 0x1f5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cf480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cc820>, '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 0x22cd520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cd9b0>, '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': 'cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:05:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:05:35 INFO - Using env: {'DISPLAY': ':0', 19:05:35 INFO - 'HOME': '/home/cltbld', 19:05:35 INFO - 'LANG': 'en_US.UTF-8', 19:05:35 INFO - 'LANGUAGE': 'en_US:en', 19:05:35 INFO - 'LOGNAME': 'cltbld', 19:05:35 INFO - 'MAIL': '/var/mail/cltbld', 19:05:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:35 INFO - 'MOZ_NO_REMOTE': '1', 19:05:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:35 INFO - 'NO_EM_RESTART': '1', 19:05:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:35 INFO - 'PWD': '/builds/slave/test', 19:05:35 INFO - 'SHELL': '/bin/bash', 19:05:35 INFO - 'SHLVL': '1', 19:05:35 INFO - 'TERM': 'linux', 19:05:35 INFO - 'TMOUT': '86400', 19:05:35 INFO - 'USER': 'cltbld', 19:05:35 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077', 19:05:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:35 INFO - '_': '/tools/buildbot/bin/python'} 19:05:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 19:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:05:35 INFO - Cleaning up... 19:05:35 INFO - Return code: 0 19:05:35 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:05:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:05:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:05:35 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 0x1f5d1f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206ea80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22cf480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22cc820>, '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 0x22cd520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cd9b0>, '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': 'cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 19:05:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:05:35 INFO - Using env: {'DISPLAY': ':0', 19:05:35 INFO - 'HOME': '/home/cltbld', 19:05:35 INFO - 'LANG': 'en_US.UTF-8', 19:05:35 INFO - 'LANGUAGE': 'en_US:en', 19:05:35 INFO - 'LOGNAME': 'cltbld', 19:05:35 INFO - 'MAIL': '/var/mail/cltbld', 19:05:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:35 INFO - 'MOZ_NO_REMOTE': '1', 19:05:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:35 INFO - 'NO_EM_RESTART': '1', 19:05:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:35 INFO - 'PWD': '/builds/slave/test', 19:05:35 INFO - 'SHELL': '/bin/bash', 19:05:35 INFO - 'SHLVL': '1', 19:05:35 INFO - 'TERM': 'linux', 19:05:35 INFO - 'TMOUT': '86400', 19:05:35 INFO - 'USER': 'cltbld', 19:05:35 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077', 19:05:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:35 INFO - '_': '/tools/buildbot/bin/python'} 19:05:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:05:35 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:05:35 INFO - Cleaning up... 19:05:35 INFO - Return code: 0 19:05:35 INFO - Running post-action listener: _resource_record_post_action 19:05:35 INFO - Running post-action listener: _start_resource_monitoring 19:05:35 INFO - Starting resource monitoring. 19:05:35 INFO - [mozharness: 2017-01-05 03:05:35.928837Z] Finished create-virtualenv step (success) 19:05:35 INFO - [mozharness: 2017-01-05 03:05:35.929343Z] Running install step. 19:05:35 INFO - Running pre-action listener: _resource_record_pre_action 19:05:35 INFO - Running main action method: install 19:05:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:05:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:05:36 INFO - Reading from file tmpfile_stdout 19:05:36 INFO - Detecting whether we're running mozinstall >=1.0... 19:05:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:05:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:05:36 INFO - Reading from file tmpfile_stdout 19:05:36 INFO - Output received: 19:05:36 INFO - Usage: mozinstall [options] installer 19:05:36 INFO - Options: 19:05:36 INFO - -h, --help show this help message and exit 19:05:36 INFO - -d DEST, --destination=DEST 19:05:36 INFO - Directory to install application into. [default: 19:05:36 INFO - "/builds/slave/test"] 19:05:36 INFO - --app=APP Application being installed. [default: firefox] 19:05:36 INFO - mkdir: /builds/slave/test/build/application 19:05:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 19:05:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 19:05:52 INFO - Reading from file tmpfile_stdout 19:05:52 INFO - Output received: 19:05:52 INFO - /builds/slave/test/build/application/firefox/firefox 19:05:52 INFO - Running post-action listener: _resource_record_post_action 19:05:52 INFO - [mozharness: 2017-01-05 03:05:52.312637Z] Finished install step (success) 19:05:52 INFO - [mozharness: 2017-01-05 03:05:52.312911Z] Running run-tests step. 19:05:52 INFO - Running pre-action listener: _resource_record_pre_action 19:05:52 INFO - Running main action method: run_tests 19:05:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:05:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:05:52 INFO - Python 2.7.3 19:05:52 INFO - Return code: 0 19:05:52 INFO - grabbing minidump binary from tooltool 19:05:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:05:52 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 0x22cc820>, '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 0x22cd520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x22cd9b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:05:52 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:05:52 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:05:52 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 19:05:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:05:52 INFO - Return code: 0 19:05:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:05:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:05:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:05:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:05:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:05:52 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/f5Ky-r_QQvOycseDCgcSlA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 19:05:52 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/f5Ky-r_QQvOycseDCgcSlA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 19:05:52 INFO - Using env: {'DISPLAY': ':0', 19:05:52 INFO - 'HOME': '/home/cltbld', 19:05:52 INFO - 'LANG': 'en_US.UTF-8', 19:05:52 INFO - 'LANGUAGE': 'en_US:en', 19:05:52 INFO - 'LOGNAME': 'cltbld', 19:05:52 INFO - 'MAIL': '/var/mail/cltbld', 19:05:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:05:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:05:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:05:52 INFO - 'MOZ_NO_REMOTE': '1', 19:05:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:05:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:05:52 INFO - 'NO_EM_RESTART': '1', 19:05:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:05:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:05:52 INFO - 'PWD': '/builds/slave/test', 19:05:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:05:52 INFO - 'SHELL': '/bin/bash', 19:05:52 INFO - 'SHLVL': '1', 19:05:52 INFO - 'TERM': 'linux', 19:05:52 INFO - 'TMOUT': '86400', 19:05:52 INFO - 'USER': 'cltbld', 19:05:52 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077', 19:05:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:05:52 INFO - '_': '/tools/buildbot/bin/python'} 19:05:52 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/f5Ky-r_QQvOycseDCgcSlA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 19:05:52 INFO - mozversion application_buildid: 20170105023344 19:05:52 INFO - mozversion application_changeset: f13abb8ba9f366c9f32a3146245adf642528becd 19:05:52 INFO - mozversion application_display_name: Nightly 19:05:52 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:05:52 INFO - mozversion application_name: Firefox 19:05:52 INFO - mozversion application_remotingname: firefox 19:05:52 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 19:05:52 INFO - mozversion application_vendor: Mozilla 19:05:52 INFO - mozversion application_version: 53.0a1 19:05:52 INFO - mozversion platform_buildid: 20170105023344 19:05:52 INFO - mozversion platform_changeset: f13abb8ba9f366c9f32a3146245adf642528becd 19:05:52 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 19:05:52 INFO - mozversion platform_version: 53.0a1 19:05:52 INFO - using testdate: 1483585552 19:05:52 INFO - actual date: 1483585552 19:05:52 INFO - starting webserver on 'localhost:54169' 19:05:52 INFO - SUITE-START | Running 2 tests 19:05:52 INFO - TEST-START | dromaeo_css 19:05:52 INFO - operating with platform_type : linux_ 19:05:52 INFO - Initialising browser for dromaeo_css test... 19:05:52 INFO - TEST-INFO | started process 5416 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbgIpUE/profile http://localhost:54169/getInfo.html) 19:05:53 INFO - PROCESS | 5416 | 1483585553100 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:263 < _startProvider()@resource://gre/modules/AddonManager.jsm:758 < startup()@resource://gre/modules/AddonManager.jsm:940 < startup()@resource://gre/modules/AddonManager.jsm:2913 < observe()@resource://gre/components/addonManager.js:65 19:05:56 INFO - PROCESS | 5416 | __metrics Screen width/height:1600/1200 19:05:56 INFO - PROCESS | 5416 | colorDepth:24 19:05:56 INFO - PROCESS | 5416 | Browser inner width/height: 1024/697 19:05:56 INFO - PROCESS | 5416 | __metrics 19:05:57 ERROR - PROCESS | 5416 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 19:05:59 INFO - TEST-INFO | 5416: exit 0 19:05:59 INFO - Browser initialized. 19:05:59 INFO - Running cycle 1/1 for dromaeo_css test... 19:05:59 INFO - TEST-INFO | started process 5537 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbgIpUE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:06:11 INFO - PROCESS | 5537 | RSS: Main: 158081024 19:06:11 INFO - PROCESS | 5537 | 19:07:00 INFO - PROCESS | 5537 | 1483585620661 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 19:09:14 INFO - PROCESS | 5537 | Cycle 1(1): loaded http://localhost:54169/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54169/tests/dromaeo/cssquery-ext.html) 19:09:16 INFO - PROCESS | 5537 | RSS: Main: 165666816 19:09:16 INFO - PROCESS | 5537 | 19:10:59 INFO - PROCESS | 5537 | ************************* 19:10:59 INFO - PROCESS | 5537 | A coding exception was thrown and uncaught in a Task. 19:10:59 INFO - PROCESS | 5537 | 19:10:59 INFO - PROCESS | 5537 | Full message: ReferenceError: fetch is not defined 19:10:59 INFO - PROCESS | 5537 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 19:10:59 INFO - PROCESS | 5537 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 19:10:59 INFO - PROCESS | 5537 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 19:10:59 INFO - PROCESS | 5537 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 19:10:59 INFO - PROCESS | 5537 | TaskImpl@resource://gre/modules/Task.jsm:277:3 19:10:59 INFO - PROCESS | 5537 | asyncFunction@resource://gre/modules/Task.jsm:252:14 19:10:59 INFO - PROCESS | 5537 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 19:10:59 INFO - PROCESS | 5537 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 19:10:59 INFO - PROCESS | 5537 | TaskImpl@resource://gre/modules/Task.jsm:277:3 19:10:59 INFO - PROCESS | 5537 | asyncFunction@resource://gre/modules/Task.jsm:252:14 19:10:59 INFO - PROCESS | 5537 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 19:10:59 INFO - PROCESS | 5537 | 19:10:59 INFO - PROCESS | 5537 | ************************* 19:12:18 INFO - PROCESS | 5537 | Cycle 1(1): loaded http://localhost:54169/tests/dromaeo/cssquery-ext.html (next: http://localhost:54169/tests/dromaeo/cssquery-jquery.html) 19:12:19 INFO - PROCESS | 5537 | RSS: Main: 163082240 19:12:19 INFO - PROCESS | 5537 | 19:15:21 INFO - PROCESS | 5537 | Cycle 1(1): loaded http://localhost:54169/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54169/tests/dromaeo/cssquery-mootools.html) 19:15:22 INFO - PROCESS | 5537 | RSS: Main: 167587840 19:15:22 INFO - PROCESS | 5537 | 19:18:24 INFO - PROCESS | 5537 | Cycle 1(1): loaded http://localhost:54169/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54169/tests/dromaeo/cssquery-prototype.html) 19:18:24 INFO - PROCESS | 5537 | RSS: Main: 162848768 19:18:24 INFO - PROCESS | 5537 | 19:21:27 INFO - PROCESS | 5537 | Cycle 1(1): loaded http://localhost:54169/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54169/tests/dromaeo/cssquery-yui.html) 19:21:28 INFO - PROCESS | 5537 | RSS: Main: 166084608 19:21:28 INFO - PROCESS | 5537 | 19:24:31 INFO - PROCESS | 5537 | Cycle 1(1): loaded http://localhost:54169/tests/dromaeo/cssquery-yui.html (next: http://localhost:54169/tests/dromaeo/cssquery-dojo.html) 19:24:31 INFO - PROCESS | 5537 | RSS: Main: 166797312 19:24:31 INFO - PROCESS | 5537 | 19:24:31 INFO - PROCESS | 5537 | __start_tp_report 19:24:31 INFO - PROCESS | 5537 | _x_x_mozilla_page_load 19:24:31 INFO - PROCESS | 5537 | _x_x_mozilla_page_load_details 19:24:31 INFO - PROCESS | 5537 | |i|pagename|runs| 19:24:31 INFO - PROCESS | 5537 | |0;dojo.html;2604.7004594471637;2611.529924613571;2612.947741045179;2634.2624065261725;2648.1393547097186;4717.268823332381;4784.497627749084;4829.179039563274;4829.541193586612;4837.274408838676;4734.218853889104;4829.806807727687;4833.009233107214;4854.393200849894;4924.3105965164905;4341.044970106579;4396.648268138541;4412.735235885841;4475.351074094255;4513.323001549761;4043.5349934757587;4528.162289976365;4532.614727748129;4556.339330797033;4558.566936141061;4319.546447623017;4451.577100175478;4469.039156581318;4491.30384790358;4553.954460455403;4355.956440435587;4392.714473559208;4418.248897687401;4430.822767089313;4433.733975961452;4379.781010949471;4387.188370151533;4388.05656783793;4389.078293558357;4397.032652816375;4665.346851440801;4677.88305292367;4707.599854012413;4780.617550595944;4789.185838407479;5051.848444546669;5055.4186268579215;5056.696598204083;5060.114479966028;5144.9742751286;5122.436531981479;5130.256112863613;5134.922976155361;5138.203578445347;5144.3312369392115;4717.457492388419;4750.762461876892;4760.166970780169;4804.927926081112;4821;5214.608904332114;5224.843254702365;5227.817026404057;5230;5267.525922666979;4987.451380348159;5004.299398084271;5010.69935803853;5019.974900125476;5039.4708555601865;4994.52552007566;5049.469805670426;5119.334486516729;5119.564836988823;5123.410807757155;5062.443131255559;5113.9744301279;5150.4334523202415;5185.092608793446;5192.9740351298005;5147.3308469898675;5152.098382782998;5153.175491921274;5168.095583272912;5203.817866374735;4292.441982542249;4337.934930976038;4445.088756804847;4461.620762235247;4494.348319493721;3762.2287431076566;3765.548134223911;3795.582485926546;3802.296575133609;3849.345611246039;4425.845095421645;4428.712133711363;4429.867103986886;4469.642428605704;4472.127935052698;5103.362079740033;5136.948630513722;5137.717425541631;5166.9224961625605;5167.328247327899;4355.956440435619;4380.277254253013;4390.62679672225;4436.955630443655;4462.553744625577;4620.768961551909;4642.0715856828765;4646.976765116153;4649.488556258809;4695.647826413033;4773.498782627774;4780.948191397887;4797.112534181258;4800.3759511263315;4849.199882019428;5018;5052.292679024866;5093.388793344674;5155.845324640267;5163.070647283525;4804.25534042224;4805.8077676892535;4816.590589799906;4854.441739200037;4856.247281671346;4928.950710492993;4930.852074437773;5000.67495612784;5067.721275329893;5080.034793389244;5089.720065396439;5138.717370544656;5174.14626586609;5208.635395522277;5217.8173763918085;4982.177940639899;5040.873978150576;5041.193409054534;5041.773120209673;5046.924296135488;4810.927836082532;4876.80492780299;5019;5029.06962211992;5033.874153146201;4823.975880120717;4841.8547443576745;4879.780409881493;4882.316475693335;4891.144049791344;4931.235658472942;4935.629827763004;4965.751712414437;4981.950180498148;4982.875428114181;4821.831235906867;4822.083804077214;4825.252085926687;4860.708357498562;4866.318715379921 19:24:31 INFO - PROCESS | 5537 | |1;ext.html;516.4757770862574;528.6114705691318;532.7975369359643;541.0180522351931;554;38523;40427.978601069975;40621.7968910155;40641.39037914434;40868;40615.390769138416;41450.792746036306;41560.79219603898;41648;41799.37300940481;7443.478956473049;7676.923230767705;7700.845983080335;9437.339386242966;9693.806123877519;9507.667231646894;9566.282528810332;9574.904250957507;9587.520623968809;9602.279829012818;9463.668771592995;9600.279979001569;9623.759406014835;9624.374415662995;9628.903710962872;9530.666426675032;9599.712008639752;9603.375780574275;9614.134727874454;9622.123685881255;9445.527723613792;9447.196988255937;9503.192228660571;9514.571844267024;9516.476593787338;34545.48181777275;34986;35020.47469287963;35105;35124;3405.3019131078067;3426.2633533790104;3450.413429716954;3468.0809585459874;3472.4791281307753;25658.743412565822;26172.8691356542;26245.73754262452;26259.73740262592;26271.73728262712;3425.828708564562;3489.842957066938;3551.5027896094566;3690.409534474471;3691.077230692327;253634;254031;255297;255359;255994;47756.7612161937;47853.28220076702;48118;48216.27675584869;48363.27455088177;50244.74877625588;50316.49683503118;50442.495575044515;50635.24047139296;50766.492335076175;13470.93264533671;13688.589342319747;13738.519151829638;13739.24434156131;13764.17414955106;9078.228350590141;9394.483303418241;9996.150327222267;10242.129418999468;10401.063904248502;15967.680646387007;15993.520194394187;15998.840011599968;16091.114988675501;16166.67666646684;6533.967330163414;6565.376289252609;6677.599344039373;6698.765543205965;6806.42145417645;805.3315747929205;811.1563973467646;818.439369032203;832.7252006837729;840.8696652018947;27857.860710696317;28047.71952280492;28291;28412;28525;925.2135684667978;933.1321870660352;946.4747065378781;957.6313119449062;968.1528662420383;14011.649708757363;14941.327640256215;14946.973429482907;14970;15246.923765381323;353925;357973;358099;358580;358806;51090.23364649533;51448.48551514437;51548.22677659838;51584;51780.741096294274;1168.8831214448223;1199.7300607363447;1210.5460452330376;1219.8719134490927;1254.0782524844233;25919.740802591732;26833;27511.31221719473;27973;29289.414211716074;48794;49717;53456.46543534515;53982.19026714681;54016;336001;346382;346713;347313;348184;39927.600723992386;40271.19457610773;40797;41194.38208426936;43487.347689784045;43951.340729889715;44283;44301.33547996847;44658.77670611626;45693.31460028169;35497.645023549434;37627.43558846565;37627.75054098815;39174;40006.59993400029;38730;38832.80583597064;39395.2120957585;39690.40464393094;39813.800930996316;36402.27195456129;36939.44590831086;37798.81100594479;37995.620043800314;38923.41614875723;32421.837890810395;34817.825910870284;34833;35227;35349.82325088358;26470.338241544116;26542.734572654026;26674.59988100219;26838.731612683623;27140.185794426197 19:24:31 INFO - PROCESS | 5537 | |2;jquery.html;368.64794121613846;369.9260147970406;375.4349703695937;380.0517708317748;392.54856914548265;17096.230669619865;18495.81504184958;18567.350142745006;19044.333448329293;19165.32921347753;17881.374151904685;18067.36764213253;18264.543386415346;18370.540736481595;18418.26326946924;5020.7489625518665;5214.661047031931;5222.268882356473;5233.371995360562;5237.188235823453;4945.159322915113;5097.5921926246;5149.40781810091;5157.432682404932;5168.043911876296;5134.383873935133;5143.27994080829;5144.922826157611;5149.459306772791;5156.123459011958;5099.949000510003;5349.197620356938;5607.327120745516;5649.180868774005;5657.462541058593;5417.83746487606;5474.863128421782;5479.561635069185;5485.6982865942355;5510.6969116698565;12114.939425302906;15928.442504512286;20027.79972200274;20932;21015.894920525454;2141.753698324697;2151.9139234430604;2206.3050139206257;2243.3270018994235;2277.806386457153;9215;9293.907060929372;9314.767130821716;9578.185854202402;9802.166815820663;1680.3868286445027;1748.0997286397514;1768.823117688221;1775.3874913154941;1777.79555351135;73564.2643573568;74473;74688.62655686741;74790.62604686996;76729.84905226482;9624.855627165598;9804.901950980542;9836.213102951746;9969.601215951281;10542;13421.530246441327;13425.530106446227;13425.731485370237;13429.127106738226;13453;6597.8350541235895;6764.594124352555;6818.93181068183;6846.075779769667;6918.861622767517;6347.650879201596;6349.936500635027;6440.645764482904;6491.578047426902;6565.573237739532;4054.270231358325;4093.815778289984;4100.671946244293;4152.626263636287;4260.552641972548;1840.190316260841;1855.1466325490155;1861.2089861808677;1899.4396652987402;1901.9714704279447;817.4890693316677;833.2251006563954;833.5290560833109;834.8497270491248;837.4682076881224;16665.41671041532;17330.82669173292;18503.444896653124;18528.351507697436;18606.627867442847;825.1212458731432;844.6705784743955;848.0205362805968;849.834282314955;852.0882655558617;9485.715428537154;10052.346597471142;10163.4918254087;10186.745331366626;10193.74515637115;483032;487779;491634;530785;544981;89562;89610.55194723984;91879.08120918839;92043.99999999866;92275.53862230646;908.9772755681029;918.4672889724078;929.2519521784893;932.1005229953128;935.0649350649351;16240.593985150466;16789;16896.57758556046;16984.745228821826;17352.273749662832;37279.81360093182;41310.79344603258;41698.79150604349;42104.78947605365;45185.32222016607;56224.71887640536;57355.42644573668;57690;58083.128753069584;59273.407265928516;5398.676079435247;6024.337322894566;7556.2443755624;7959.641816118173;8038.919610803817;8635.568221589021;9158.992510823671;9383.812323753351;12849.743005139659;13117.34413279313;10431.321964072311;10450.529726162493;10472.109870660774;10641.946790266;11278;10340.741481463023;10588.576456941637;10882.020618144405;10901.400422976496;11392.886071139183;5694.943050569441;8211.548364839991;10473.26687131924;10957.232993690364;11297.43512824372;7661.923380766121;7718.691252349843;7725.884111738216;7782.649780759766;8039.316658083894;7838.490498117832;9625.229981601595;10270.33242839213;10788.784224315626;10795.6221532246 19:24:31 INFO - PROCESS | 5537 | |3;mootools.html;1276.1194775604831;1298.4806077568974;1307.725377670689;1310.50200923649;1315.4475120449413;6124.265088189412;6318.210223722035;6673;7098.716051357946;7100.147982242125;6652.434543063845;6878.587284762918;6941.652917354125;6995;7072.328128827766;2065.6075345684308;2101.117530637136;2102.1801497415945;2102.7686954435076;2108.652072408051;1691.6954948109335;1748.8863223890407;1915.329634627883;1983.3058429549615;1989.0850208903921;1995.650761116806;2070.0891607692565;2075.0765909170427;2081.5004398944297;2084.3434318189798;2012.1247257443058;2031.837453003756;2042.6527490326532;2049.467138543982;2056.7531896172554;2012.748406449194;2035.4809523571394;2049.2008116834445;2053.5276886316083;2084.749830020392;6964.651767411609;6966.4078553323025;6986.231514533448;7014.193367762721;7016.333448322402;4062.6343629073526;4158.563350848148;4167.291560434734;4203.55862634422;4206.705530612859;2564.1794625719776;2665.315127303077;2750.477409292228;2760.8619569021466;2780.4856101621062;1104.828751543512;1108.6673997800708;1118.7538741476862;1140.7604403075363;1150.8618965724083;9184;9205.401648892801;9222.584983675752;9224.07759224079;9242.306826988002;3748.6438788315068;3851.9422208666892;3890.4553362528704;3931.8820435386983;3948.980255098706;7898.605069746604;7923.7226697065325;7930.801729956682;7951.801204969922;7952.32405245549;4231.4710661167355;4307.396964424983;4311.0300182458695;4322.848700295474;4327;3848.3265428549894;3965.9008524786536;3975.0658595230097;3976.4234186042863;3982.681385489154;3332.216929021678;3356.0435275946725;3423.281110966675;3432.2792213634916;3526.3828829954655;1018.0582960761266;1052.7315534538798;1093.2456604942565;1126.318577260762;1128.136975213962;712.5404114346218;733.7835338575027;740.8555331710372;747.5215861848421;818.5211651184125;4616.60758835496;4772.3557319762085;4780.306855506002;4876.829310974099;4952.603791696655;929.0987741890491;934.462683956714;943.2265542255285;944.6552008516842;963.5278713430368;3256.690614391629;3409.9488507672404;3448.8620455181513;3500.7199424046016;3502.1419752160373;7592.696292148252;7938.603069846485;8010.158933312035;8058.073321568095;8134.715284965117;7951.522908625501;8022.79943001418;8034.116247212802;8040.075391330072;8054.919450805534;6296.905546416808;6359.300476947532;6385.680715964276;6437.903431448532;6506.284308726036;4740.194166991689;4741.596964258077;4754.31062495943;4851.434195866106;4939.777710003131;7402.518836275625;7464.664090115849;7491.063617047869;7524.811879703051;7545.471816972979;7503.2496750324535;7516.5114267572435;7565.130010048915;7630.542167469969;7693.923060769321;5966.105084237399;6022.668753218615;6033.758649653964;6035.486983606443;6043.033114701627;6478.2550006749825;6541.738330466728;6546.24718157418;6553.639549824615;6556.409923106943;5279.89440211186;5867.383924687846;6000.129981152796;6109.7861574844665;6121.510279177566;5727.198192253005;5827.125931110368;5827.388124246893;5845.3570107289015;5953.732082056231;5204.557612602971;5394.595405344693;5453.454654534515;5457.754401052041;5565.638233514808;4143.544210136823;4153.293940030142;4238.660907127484;4248.787560622019;4348.8043038064;4299.161663475717;4369.431973843507;4379.408779814812;4427.402300689366;4492.707973981812 19:24:31 INFO - PROCESS | 5537 | |4;prototype.html;332.9250918543328;337.3506000948176;337.6370401818046;339.5992728580274;342.13439996808086;4961.900761984758;4979.975100124503;5034.899302013962;5043.998820701686;5052.393712754465;4956.942868709481;4977.502249775021;4998.150314446544;4999.875003124915;5039.596832253411;3727.7390582659223;3817.656410923016;3834.5015148030716;3863.594322596129;4034.2133284009556;3843.4811300474357;3875.205582855508;3882.165334453092;3884.4561761353434;3899.337112690835;3844.6539811416965;3851.919963219858;3860;3867.5939026402243;3871.59348268432;3731.328360895038;3858.614138586147;3859.5140870764676;3867.149227170018;3871.49670542829;3335.2495688470144;3347.09628400333;3366.7138293245102;3378.121688361019;3379.3410284994434;4883.438404583483;4919.77860996256;4923.359963204761;4944.851654450372;4956.405231372222;4414.984553552701;4427.490838553543;4436.93344599828;4451.399061126739;4453.153900758845;5008.699478031293;5178.870528236786;5240.213967904807;5274.525292723673;5312.867178320535;3680.2087551176623;3688.981555092234;3696.094456858087;3713.294474049922;3713.5543734752005;5477.260569823103;5477.726113694339;5496.972515137439;5527.397054854087;5528;3662.5788034375855;3743.232637309345;3747.550293964687;3749;3762.830672619739;3772.679322257584;3797.5063241778394;3803.5625903020955;3810.142717888453;3822.961770382316;4364.672649551297;4405.713628614129;4412.947979189692;4413.256763578369;4450.310201918708;5111.693298402108;5322.023907646363;5334.546563542065;5346.599005074635;5373.952079344568;1259.4962015193812;1259.7165637731437;1269.990357665658;1279.3858947705153;1281.3657239666425;838.2916435611899;857.7941294089374;865.6234537976001;868.7524055644111;871.9956400217958;4390.073400908747;4407.515173330931;4460.7323560586465;4642.1644104060915;4654.4414670239785;5458.372287187024;5462.317210348707;5469.714617064987;5480.588955828329;5484.972575137179;4614.7461889595725;4636.420447444069;4647.16351056813;4648.767561621906;4659.58063774262;2724.1555117913113;2792.3577577157366;2802.607634931111;2809.2134202423354;2814.4230432761233;4877.195262781673;4895.412550493892;4895.632827537877;4903.779329930162;4929.852104436873;5392.514673679388;5417.853039612305;5426.097038084606;5429.267048948421;5453;4663.930041049387;4889.951100488949;4919.532644398776;4934.605231581393;4963.230699241623;5277.815276465459;5324.124972514798;5347.331583552056;5359.383670877899;5367.194920761917;4947.208446648519;5209.791608335776;5213.6350455467755;5217.843464696065;5229.973850130725;4832.830850920201;4860.222364421676;4860.95139048605;4875.90248195027;4899.975500122477;3630.3283892479976;3646.6717995380545;3663.413853783382;3665.17533554948;3668.8715894944617;5252.868678283074;5294;5301.628885977944;5306.7098398992875;5310.468953104659;4934.284528743384;5239.004589128053;5263.315708988367;5264.341957255343;5273.34083239595;5231.267622532772;5235.712035838065;5266.9736651318035;5267.6813607427075;5273.024490469275;4978.4274808397495;5156.896862062813;5156.948430515647;5178.43037265908;5187.273781670645;5166.586673066221;5272.525472707474;5301.496357845998;5337.599680023936;5351.441291541238;5105.668131571436;5162.328897243335;5183.3261675981885;5184.533391994739;5208.921866172086 19:24:31 INFO - PROCESS | 5537 | |5;yui.html;669.3172963577155;690.8031211104833;735.1802739944962;759.5556599389357;792.5601291283338;11000.449977501123;11836.7632647347;11848.763024739521;11849.229800063;11850.170488065838;11394.316341019545;11430.485628146733;11449.656510304683;11466.08271338293;11580.59467918623;654.3816093791369;673.1551902362528;778.3423007558604;793.2266040610402;796.3111908199423;789.7551758954743;808.640155130964;809.9635516401776;811.2009670474578;811.5860910935436;855.6491838346279;858.1375717404001;859.1966511311944;859.866720658299;859.8882145321131;848.9108643592426;850.2900078434515;850.6257246811414;851.0085750101125;851.953142577158;623.7286780250605;625.8404106952744;626.7117126121989;627.5356236385088;629.1443636654146;11617.361045142514;11893.40532973348;12207.084468664885;12324.753504929851;12329.69175770604;13587.796183057262;14294.499692510712;14320.785188222186;14424.423023079064;14510.347034383478;9848.753781155528;10075.798484030352;10097.899021009769;10124.645637402655;10283.691489255334;3312.8840490582716;3335.28291417344;3337.1156643489494;3382.52644629752;3404.2510647657477;66666.3333366665;67921.320786792;69017.30982690159;69673;70606.94089588609;10783.892161078289;10801.567937282578;10866.402347870784;10894.128469722404;10995.34027958325;20611.69082463764;20756.06597703107;20773.67621180604;20877.164913403598;20964.685529717066;6838.247792742794;6970.512064155562;7070.611116388648;7152.713891444388;7227.457940654472;3697.4084146536425;3718.5165928429133;3722.4788529605876;3727.7576957497677;3738.6635202831876;2799.5520716685232;2831.3063299491755;2849.344650730344;2859.914202573926;2876.2090425133256;470.04346155573245;475.1447394689614;478.4450037955954;487.46865916151563;487.76831005272214;628.8836565235446;630.6606518484634;641.8170821315996;644.6831054225981;660.7654282729658;8076.434649574473;8089.312408445348;8265.5691194982;8305.501669899826;8511.106333834858;635.2599221906427;637.9425851673371;642.7750287399373;643.3662842100528;644.407145426209;3875.302445559826;3894.3768996960353;3969.4045893116263;3999.3601023836045;4036.798160091984;68871.96692049623;69999;71116;71657.2834271661;73334.63332683302;60561;60590.39409605935;60758.69620651868;60787.69606151941;61088;41360.37959430611;51200.48799512032;52552.21171682428;53019.20471192935;53143.73428132835;7355.926440735524;7561.281678240558;7696;7843.450958432855;7881.330086942674;30383.2599558733;30451.39097217999;33805.32389352249;34851.25743712753;36085.45871811977;39162.608373917035;42413;48082;48678;48744.512554873996;9158.862617060882;9338.486383248986;9343.672971445967;9555.426674399558;9653.420794752337;11077.446127693422;11186.888131118585;11242.718932026764;11287.943560282147;11982.400879955792;10216.693499195037;10269.691909242734;10310.793784124426;10359.792804144026;10362;10059.28399332191;10062.446565438971;10079;10268.897311026794;10343.482825858828;10125.898741012496;10444.947775261075;10760.300580462244;11299.943500282447;11400.144989125683;9274.629014839331;9711.805763884824;9736.902630973884;9813.656522021694;10014.799704005733;9571.808563828823;9657.372270802376;9739.123478886933;9753.268504862306;9761.951190244003 19:24:31 INFO - PROCESS | 5537 | __end_tp_report 19:24:31 INFO - PROCESS | 5537 | __start_cc_report 19:24:31 INFO - PROCESS | 5537 | _x_x_mozilla_cycle_collect,350 19:24:31 INFO - PROCESS | 5537 | __end_cc_report 19:24:31 INFO - PROCESS | 5537 | __startTimestamp1483586671585__endTimestamp 19:24:31 INFO - PROCESS | 5537 | 19:24:31 INFO - PROCESS | 5537 | ------- Summary: start ------- 19:24:31 INFO - PROCESS | 5537 | Number of tests: 6 19:24:31 INFO - PROCESS | 5537 | 19:24:31 INFO - PROCESS | 5537 | [#0] dojo.html Cycles:165 Average:4730.29 Median:4829.81 stddev:497.00 (10.3%) stddev-sans-first:469.72 19:24:31 INFO - PROCESS | 5537 | Values: 2604.7 2611.5 2612.9 2634.3 2648.1 4717.3 4784.5 4829.2 4829.5 4837.3 4734.2 4829.8 4833.0 4854.4 4924.3 4341.0 4396.6 4412.7 4475.4 4513.3 4043.5 4528.2 4532.6 4556.3 4558.6 4319.5 4451.6 4469.0 4491.3 4554.0 4356.0 4392.7 4418.2 4430.8 4433.7 4379.8 4387.2 4388.1 4389.1 4397.0 4665.3 4677.9 4707.6 4780.6 4789.2 5051.8 5055.4 5056.7 5060.1 5145.0 5122.4 5130.3 5134.9 5138.2 5144.3 4717.5 4750.8 4760.2 4804.9 4821.0 5214.6 5224.8 5227.8 5230.0 5267.5 4987.5 5004.3 5010.7 5020.0 5039.5 4994.5 5049.5 5119.3 5119.6 5123.4 5062.4 5114.0 5150.4 5185.1 5193.0 5147.3 5152.1 5153.2 5168.1 5203.8 4292.4 4337.9 4445.1 4461.6 4494.3 3762.2 3765.5 3795.6 3802.3 3849.3 4425.8 4428.7 4429.9 4469.6 4472.1 5103.4 5136.9 5137.7 5166.9 5167.3 4356.0 4380.3 4390.6 4437.0 4462.6 4620.8 4642.1 4647.0 4649.5 4695.6 4773.5 4780.9 4797.1 4800.4 4849.2 5018.0 5052.3 5093.4 5155.8 5163.1 4804.3 4805.8 4816.6 4854.4 4856.2 4929.0 4930.9 5000.7 5067.7 5080.0 5089.7 5138.7 5174.1 5208.6 5217.8 4982.2 5040.9 5041.2 5041.8 5046.9 4810.9 4876.8 5019.0 5029.1 5033.9 4824.0 4841.9 4879.8 4882.3 4891.1 4931.2 4935.6 4965.8 4982.0 4982.9 4821.8 4822.1 4825.3 4860.7 4866.3 19:24:31 INFO - PROCESS | 5537 | 19:24:31 INFO - PROCESS | 5537 | [#1] ext.html Cycles:180 Average:48271.44 Median:39752.10 stddev:84583.79 (212.8%) stddev-sans-first:84745.07 19:24:31 INFO - PROCESS | 5537 | Values: 516.5 528.6 532.8 541.0 554.0 38523.0 40428.0 40621.8 40641.4 40868.0 40615.4 41450.8 41560.8 41648.0 41799.4 7443.5 7676.9 7700.8 9437.3 9693.8 9507.7 9566.3 9574.9 9587.5 9602.3 9463.7 9600.3 9623.8 9624.4 9628.9 9530.7 9599.7 9603.4 9614.1 9622.1 9445.5 9447.2 9503.2 9514.6 9516.5 34545.5 34986.0 35020.5 35105.0 35124.0 3405.3 3426.3 3450.4 3468.1 3472.5 25658.7 26172.9 26245.7 26259.7 26271.7 3425.8 3489.8 3551.5 3690.4 3691.1 253634.0 254031.0 255297.0 255359.0 255994.0 47756.8 47853.3 48118.0 48216.3 48363.3 50244.7 50316.5 50442.5 50635.2 50766.5 13470.9 13688.6 13738.5 13739.2 13764.2 9078.2 9394.5 9996.2 10242.1 10401.1 15967.7 15993.5 15998.8 16091.1 16166.7 6534.0 6565.4 6677.6 6698.8 6806.4 805.3 811.2 818.4 832.7 840.9 27857.9 28047.7 28291.0 28412.0 28525.0 925.2 933.1 946.5 957.6 968.2 14011.6 14941.3 14947.0 14970.0 15246.9 353925.0 357973.0 358099.0 358580.0 358806.0 51090.2 51448.5 51548.2 51584.0 51780.7 1168.9 1199.7 1210.5 1219.9 1254.1 25919.7 26833.0 27511.3 27973.0 29289.4 48794.0 49717.0 53456.5 53982.2 54016.0 336001.0 346382.0 346713.0 347313.0 348184.0 39927.6 40271.2 40797.0 41194.4 43487.3 43951.3 44283.0 44301.3 44658.8 45693.3 35497.6 37627.4 37627.8 39174.0 40006.6 38730.0 38832.8 39395.2 39690.4 39813.8 36402.3 36939.4 37798.8 37995.6 38923.4 32421.8 34817.8 34833.0 35227.0 35349.8 26470.3 26542.7 26674.6 26838.7 27140.2 19:24:31 INFO - PROCESS | 5537 | 19:24:31 INFO - PROCESS | 5537 | [#2] jquery.html Cycles:180 Average:28436.95 Median:5138.83 stddev:83762.70 (1630.0%) stddev-sans-first:83971.16 19:24:31 INFO - PROCESS | 5537 | Values: 368.6 369.9 375.4 380.1 392.5 17096.2 18495.8 18567.4 19044.3 19165.3 17881.4 18067.4 18264.5 18370.5 18418.3 5020.7 5214.7 5222.3 5233.4 5237.2 4945.2 5097.6 5149.4 5157.4 5168.0 5134.4 5143.3 5144.9 5149.5 5156.1 5099.9 5349.2 5607.3 5649.2 5657.5 5417.8 5474.9 5479.6 5485.7 5510.7 12114.9 15928.4 20027.8 20932.0 21015.9 2141.8 2151.9 2206.3 2243.3 2277.8 9215.0 9293.9 9314.8 9578.2 9802.2 1680.4 1748.1 1768.8 1775.4 1777.8 73564.3 74473.0 74688.6 74790.6 76729.8 9624.9 9804.9 9836.2 9969.6 10542.0 13421.5 13425.5 13425.7 13429.1 13453.0 6597.8 6764.6 6818.9 6846.1 6918.9 6347.7 6349.9 6440.6 6491.6 6565.6 4054.3 4093.8 4100.7 4152.6 4260.6 1840.2 1855.1 1861.2 1899.4 1902.0 817.5 833.2 833.5 834.8 837.5 16665.4 17330.8 18503.4 18528.4 18606.6 825.1 844.7 848.0 849.8 852.1 9485.7 10052.3 10163.5 10186.7 10193.7 483032.0 487779.0 491634.0 530785.0 544981.0 89562.0 89610.6 91879.1 92044.0 92275.5 909.0 918.5 929.3 932.1 935.1 16240.6 16789.0 16896.6 16984.7 17352.3 37279.8 41310.8 41698.8 42104.8 45185.3 56224.7 57355.4 57690.0 58083.1 59273.4 5398.7 6024.3 7556.2 7959.6 8038.9 8635.6 9159.0 9383.8 12849.7 13117.3 10431.3 10450.5 10472.1 10641.9 11278.0 10340.7 10588.6 10882.0 10901.4 11392.9 5694.9 8211.5 10473.3 10957.2 11297.4 7661.9 7718.7 7725.9 7782.6 8039.3 7838.5 9625.2 10270.3 10788.8 10795.6 19:24:31 INFO - PROCESS | 5537 | 19:24:31 INFO - PROCESS | 5537 | [#3] mootools.html Cycles:180 Average:4560.73 Median:4815.87 stddev:2396.83 (49.8%) stddev-sans-first:2390.84 19:24:31 INFO - PROCESS | 5537 | Values: 1276.1 1298.5 1307.7 1310.5 1315.4 6124.3 6318.2 6673.0 7098.7 7100.1 6652.4 6878.6 6941.7 6995.0 7072.3 2065.6 2101.1 2102.2 2102.8 2108.7 1691.7 1748.9 1915.3 1983.3 1989.1 1995.7 2070.1 2075.1 2081.5 2084.3 2012.1 2031.8 2042.7 2049.5 2056.8 2012.7 2035.5 2049.2 2053.5 2084.7 6964.7 6966.4 6986.2 7014.2 7016.3 4062.6 4158.6 4167.3 4203.6 4206.7 2564.2 2665.3 2750.5 2760.9 2780.5 1104.8 1108.7 1118.8 1140.8 1150.9 9184.0 9205.4 9222.6 9224.1 9242.3 3748.6 3851.9 3890.5 3931.9 3949.0 7898.6 7923.7 7930.8 7951.8 7952.3 4231.5 4307.4 4311.0 4322.8 4327.0 3848.3 3965.9 3975.1 3976.4 3982.7 3332.2 3356.0 3423.3 3432.3 3526.4 1018.1 1052.7 1093.2 1126.3 1128.1 712.5 733.8 740.9 747.5 818.5 4616.6 4772.4 4780.3 4876.8 4952.6 929.1 934.5 943.2 944.7 963.5 3256.7 3409.9 3448.9 3500.7 3502.1 7592.7 7938.6 8010.2 8058.1 8134.7 7951.5 8022.8 8034.1 8040.1 8054.9 6296.9 6359.3 6385.7 6437.9 6506.3 4740.2 4741.6 4754.3 4851.4 4939.8 7402.5 7464.7 7491.1 7524.8 7545.5 7503.2 7516.5 7565.1 7630.5 7693.9 5966.1 6022.7 6033.8 6035.5 6043.0 6478.3 6541.7 6546.2 6553.6 6556.4 5279.9 5867.4 6000.1 6109.8 6121.5 5727.2 5827.1 5827.4 5845.4 5953.7 5204.6 5394.6 5453.5 5457.8 5565.6 4143.5 4153.3 4238.7 4248.8 4348.8 4299.2 4369.4 4379.4 4427.4 4492.7 19:24:31 INFO - PROCESS | 5537 | 19:24:31 INFO - PROCESS | 5537 | [#4] prototype.html Cycles:180 Average:4312.07 Median:4901.88 stddev:1267.59 (25.9%) stddev-sans-first:1235.46 19:24:31 INFO - PROCESS | 5537 | Values: 332.9 337.4 337.6 339.6 342.1 4961.9 4980.0 5034.9 5044.0 5052.4 4956.9 4977.5 4998.2 4999.9 5039.6 3727.7 3817.7 3834.5 3863.6 4034.2 3843.5 3875.2 3882.2 3884.5 3899.3 3844.7 3851.9 3860.0 3867.6 3871.6 3731.3 3858.6 3859.5 3867.1 3871.5 3335.2 3347.1 3366.7 3378.1 3379.3 4883.4 4919.8 4923.4 4944.9 4956.4 4415.0 4427.5 4436.9 4451.4 4453.2 5008.7 5178.9 5240.2 5274.5 5312.9 3680.2 3689.0 3696.1 3713.3 3713.6 5477.3 5477.7 5497.0 5527.4 5528.0 3662.6 3743.2 3747.6 3749.0 3762.8 3772.7 3797.5 3803.6 3810.1 3823.0 4364.7 4405.7 4412.9 4413.3 4450.3 5111.7 5322.0 5334.5 5346.6 5374.0 1259.5 1259.7 1270.0 1279.4 1281.4 838.3 857.8 865.6 868.8 872.0 4390.1 4407.5 4460.7 4642.2 4654.4 5458.4 5462.3 5469.7 5480.6 5485.0 4614.7 4636.4 4647.2 4648.8 4659.6 2724.2 2792.4 2802.6 2809.2 2814.4 4877.2 4895.4 4895.6 4903.8 4929.9 5392.5 5417.9 5426.1 5429.3 5453.0 4663.9 4890.0 4919.5 4934.6 4963.2 5277.8 5324.1 5347.3 5359.4 5367.2 4947.2 5209.8 5213.6 5217.8 5230.0 4832.8 4860.2 4861.0 4875.9 4900.0 3630.3 3646.7 3663.4 3665.2 3668.9 5252.9 5294.0 5301.6 5306.7 5310.5 4934.3 5239.0 5263.3 5264.3 5273.3 5231.3 5235.7 5267.0 5267.7 5273.0 4978.4 5156.9 5156.9 5178.4 5187.3 5166.6 5272.5 5301.5 5337.6 5351.4 5105.7 5162.3 5183.3 5184.5 5208.9 19:24:31 INFO - PROCESS | 5537 | 19:24:31 INFO - PROCESS | 5537 | [#5] yui.html Cycles:180 Average:14865.87 Median:49972.50 stddev:19395.67 (38.8%) stddev-sans-first:19420.78 19:24:31 INFO - PROCESS | 5537 | Values: 669.3 690.8 735.2 759.6 792.6 11000.4 11836.8 11848.8 11849.2 11850.2 11394.3 11430.5 11449.7 11466.1 11580.6 654.4 673.2 778.3 793.2 796.3 789.8 808.6 810.0 811.2 811.6 855.6 858.1 859.2 859.9 859.9 848.9 850.3 850.6 851.0 852.0 623.7 625.8 626.7 627.5 629.1 11617.4 11893.4 12207.1 12324.8 12329.7 13587.8 14294.5 14320.8 14424.4 14510.3 9848.8 10075.8 10097.9 10124.6 10283.7 3312.9 3335.3 3337.1 3382.5 3404.3 66666.3 67921.3 69017.3 69673.0 70606.9 10783.9 10801.6 10866.4 10894.1 10995.3 20611.7 20756.1 20773.7 20877.2 20964.7 6838.2 6970.5 7070.6 7152.7 7227.5 3697.4 3718.5 3722.5 3727.8 3738.7 2799.6 2831.3 2849.3 2859.9 2876.2 470.0 475.1 478.4 487.5 487.8 628.9 630.7 641.8 644.7 660.8 8076.4 8089.3 8265.6 8305.5 8511.1 635.3 637.9 642.8 643.4 644.4 3875.3 3894.4 3969.4 3999.4 4036.8 68872.0 69999.0 71116.0 71657.3 73334.6 60561.0 60590.4 60758.7 60787.7 61088.0 41360.4 51200.5 52552.2 53019.2 53143.7 7355.9 7561.3 7696.0 7843.5 7881.3 30383.3 30451.4 33805.3 34851.3 36085.5 39162.6 42413.0 48082.0 48678.0 48744.5 9158.9 9338.5 9343.7 9555.4 9653.4 11077.4 11186.9 11242.7 11287.9 11982.4 10216.7 10269.7 10310.8 10359.8 10362.0 10059.3 10062.4 10079.0 10268.9 10343.5 10125.9 10444.9 10760.3 11299.9 11400.1 9274.6 9711.8 9736.9 9813.7 10014.8 9571.8 9657.4 9739.1 9753.3 9762.0 19:24:31 INFO - PROCESS | 5537 | -------- Summary: end -------- 19:24:31 INFO - PROCESS | 5537 | 19:24:32 INFO - TEST-INFO | 5537: exit 0 19:24:32 INFO - TEST-OK | dromaeo_css | took 1119862ms 19:24:32 INFO - TEST-START | kraken 19:24:32 INFO - operating with platform_type : linux_ 19:24:32 INFO - Initialising browser for kraken test... 19:24:32 INFO - TEST-INFO | started process 5890 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9WccEC/profile http://localhost:54169/getInfo.html) 19:24:33 INFO - PROCESS | 5890 | 1483586673001 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:263 < _startProvider()@resource://gre/modules/AddonManager.jsm:758 < startup()@resource://gre/modules/AddonManager.jsm:940 < startup()@resource://gre/modules/AddonManager.jsm:2913 < observe()@resource://gre/components/addonManager.js:65 19:24:36 INFO - PROCESS | 5890 | __metrics Screen width/height:1600/1200 19:24:36 INFO - PROCESS | 5890 | colorDepth:24 19:24:36 INFO - PROCESS | 5890 | Browser inner width/height: 1024/697 19:24:36 INFO - PROCESS | 5890 | __metrics 19:24:37 ERROR - PROCESS | 5890 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 19:24:38 INFO - TEST-INFO | 5890: exit 0 19:24:38 INFO - Browser initialized. 19:24:38 INFO - Running cycle 1/1 for kraken test... 19:24:38 INFO - TEST-INFO | started process 6012 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp9WccEC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:24:50 INFO - PROCESS | 6012 | RSS: Main: 158175232 19:24:50 INFO - PROCESS | 6012 | 19:24:53 INFO - PROCESS | 6012 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54169/tests/kraken/driver.html?testName=audio-beat-detection) 19:24:54 INFO - PROCESS | 6012 | RSS: Main: 164220928 19:24:54 INFO - PROCESS | 6012 | 19:24:57 INFO - PROCESS | 6012 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54169/tests/kraken/driver.html?testName=audio-dft) 19:24:57 INFO - PROCESS | 6012 | RSS: Main: 163229696 19:24:57 INFO - PROCESS | 6012 | 19:25:00 INFO - PROCESS | 6012 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54169/tests/kraken/driver.html?testName=audio-fft) 19:25:01 INFO - PROCESS | 6012 | RSS: Main: 160268288 19:25:01 INFO - PROCESS | 6012 | 19:25:03 INFO - PROCESS | 6012 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54169/tests/kraken/driver.html?testName=audio-oscillator) 19:25:04 INFO - PROCESS | 6012 | RSS: Main: 160579584 19:25:04 INFO - PROCESS | 6012 | 19:25:06 INFO - PROCESS | 6012 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54169/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:25:06 INFO - PROCESS | 6012 | RSS: Main: 160915456 19:25:06 INFO - PROCESS | 6012 | 19:25:10 INFO - PROCESS | 6012 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54169/tests/kraken/driver.html?testName=imaging-darkroom) 19:25:10 INFO - PROCESS | 6012 | RSS: Main: 165502976 19:25:10 INFO - PROCESS | 6012 | 19:25:14 INFO - PROCESS | 6012 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54169/tests/kraken/driver.html?testName=imaging-desaturate) 19:25:14 INFO - PROCESS | 6012 | RSS: Main: 162148352 19:25:14 INFO - PROCESS | 6012 | 19:25:17 INFO - PROCESS | 6012 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54169/tests/kraken/driver.html?testName=json-parse-financial) 19:25:18 INFO - PROCESS | 6012 | RSS: Main: 162893824 19:25:18 INFO - PROCESS | 6012 | 19:25:20 INFO - PROCESS | 6012 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54169/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:25:20 INFO - PROCESS | 6012 | RSS: Main: 162828288 19:25:20 INFO - PROCESS | 6012 | 19:25:22 INFO - PROCESS | 6012 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54169/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:25:23 INFO - PROCESS | 6012 | RSS: Main: 162803712 19:25:23 INFO - PROCESS | 6012 | 19:25:25 INFO - PROCESS | 6012 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54169/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:25:26 INFO - PROCESS | 6012 | RSS: Main: 163770368 19:25:26 INFO - PROCESS | 6012 | 19:25:29 INFO - PROCESS | 6012 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54169/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:25:29 INFO - PROCESS | 6012 | RSS: Main: 163807232 19:25:29 INFO - PROCESS | 6012 | 19:25:32 INFO - PROCESS | 6012 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54169/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:25:33 INFO - PROCESS | 6012 | RSS: Main: 166232064 19:25:33 INFO - PROCESS | 6012 | 19:25:35 INFO - PROCESS | 6012 | Cycle 1(1): loaded http://localhost:54169/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54169/tests/kraken/driver.html?testName=ai-astar) 19:25:35 INFO - PROCESS | 6012 | RSS: Main: 167251968 19:25:35 INFO - PROCESS | 6012 | 19:25:35 INFO - PROCESS | 6012 | __start_tp_report 19:25:35 INFO - PROCESS | 6012 | _x_x_mozilla_page_load 19:25:35 INFO - PROCESS | 6012 | _x_x_mozilla_page_load_details 19:25:35 INFO - PROCESS | 6012 | |i|pagename|runs| 19:25:35 INFO - PROCESS | 6012 | |0;ai-astar;108;118;120;116;115;116;117;117;117;117 19:25:35 INFO - PROCESS | 6012 | |1;audio-beat-detection;154;125;126;160;126;141;133;128;162;131 19:25:35 INFO - PROCESS | 6012 | |2;audio-dft;165;165;173;164;163;162;163;163;163;163 19:25:35 INFO - PROCESS | 6012 | |3;audio-fft;77;77;79;113;80;81;78;82;92;77 19:25:35 INFO - PROCESS | 6012 | |4;audio-oscillator;85;86;116;86;86;85;112;86;85;108 19:25:35 INFO - PROCESS | 6012 | |5;imaging-gaussian-blur;119;118;118;119;122;118;118;118;118;119 19:25:35 INFO - PROCESS | 6012 | |6;imaging-darkroom;150;150;150;151;151;152;151;151;151;150 19:25:35 INFO - PROCESS | 6012 | |7;imaging-desaturate;96;97;97;96;96;97;96;96;96;97 19:25:35 INFO - PROCESS | 6012 | |8;json-parse-financial;66;69;69;67;68;70;70;74;69;69 19:25:35 INFO - PROCESS | 6012 | |9;json-stringify-tinderbox;69;67;68;68;68;68;67;67;69;68 19:25:35 INFO - PROCESS | 6012 | |10;stanford-crypto-aes;85;85;86;86;84;92;84;84;86;84 19:25:35 INFO - PROCESS | 6012 | |11;stanford-crypto-ccm;146;136;149;135;138;143;136;137;192;137 19:25:35 INFO - PROCESS | 6012 | |12;stanford-crypto-pbkdf2;183;179;180;180;179;181;177;180;181;180 19:25:35 INFO - PROCESS | 6012 | |13;stanford-crypto-sha256-iterative;70;70;69;70;69;70;69;67;78;67 19:25:35 INFO - PROCESS | 6012 | __end_tp_report 19:25:35 INFO - PROCESS | 6012 | __start_cc_report 19:25:35 INFO - PROCESS | 6012 | _x_x_mozilla_cycle_collect,802 19:25:35 INFO - PROCESS | 6012 | __end_cc_report 19:25:35 INFO - PROCESS | 6012 | __startTimestamp1483586735536__endTimestamp 19:25:35 INFO - PROCESS | 6012 | 19:25:35 INFO - PROCESS | 6012 | ------- Summary: start ------- 19:25:35 INFO - PROCESS | 6012 | Number of tests: 14 19:25:35 INFO - PROCESS | 6012 | 19:25:35 INFO - PROCESS | 6012 | [#0] ai-astar Cycles:10 Average:116.10 Median:117.00 stddev:3.14 (2.7%) stddev-sans-first:1.41 19:25:35 INFO - PROCESS | 6012 | Values: 108.0 118.0 120.0 116.0 115.0 116.0 117.0 117.0 117.0 117.0 19:25:35 INFO - PROCESS | 6012 | 19:25:35 INFO - PROCESS | 6012 | [#1] audio-beat-detection Cycles:10 Average:138.60 Median:137.00 stddev:14.73 (10.8%) stddev-sans-first:14.53 19:25:35 INFO - PROCESS | 6012 | Values: 154.0 125.0 126.0 160.0 126.0 141.0 133.0 128.0 162.0 131.0 19:25:35 INFO - PROCESS | 6012 | 19:25:35 INFO - PROCESS | 6012 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.50 stddev:3.17 (1.9%) stddev-sans-first:3.35 19:25:35 INFO - PROCESS | 6012 | Values: 165.0 165.0 173.0 164.0 163.0 162.0 163.0 163.0 163.0 163.0 19:25:35 INFO - PROCESS | 6012 | 19:25:35 INFO - PROCESS | 6012 | [#3] audio-fft Cycles:10 Average:83.60 Median:79.50 stddev:11.26 (14.2%) stddev-sans-first:11.68 19:25:35 INFO - PROCESS | 6012 | Values: 77.0 77.0 79.0 113.0 80.0 81.0 78.0 82.0 92.0 77.0 19:25:35 INFO - PROCESS | 6012 | 19:25:35 INFO - PROCESS | 6012 | [#4] audio-oscillator Cycles:10 Average:93.50 Median:85.50 stddev:12.91 (15.1%) stddev-sans-first:13.32 19:25:35 INFO - PROCESS | 6012 | Values: 85.0 86.0 116.0 86.0 86.0 85.0 112.0 86.0 85.0 108.0 19:25:35 INFO - PROCESS | 6012 | 19:25:35 INFO - PROCESS | 6012 | [#5] imaging-gaussian-blur Cycles:10 Average:118.70 Median:118.50 stddev:1.25 (1.1%) stddev-sans-first:1.32 19:25:35 INFO - PROCESS | 6012 | Values: 119.0 118.0 118.0 119.0 122.0 118.0 118.0 118.0 118.0 119.0 19:25:35 INFO - PROCESS | 6012 | 19:25:35 INFO - PROCESS | 6012 | [#6] imaging-darkroom Cycles:10 Average:150.70 Median:151.00 stddev:0.67 (0.4%) stddev-sans-first:0.67 19:25:35 INFO - PROCESS | 6012 | Values: 150.0 150.0 150.0 151.0 151.0 152.0 151.0 151.0 151.0 150.0 19:25:35 INFO - PROCESS | 6012 | 19:25:35 INFO - PROCESS | 6012 | [#7] imaging-desaturate Cycles:10 Average:96.40 Median:96.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 19:25:35 INFO - PROCESS | 6012 | Values: 96.0 97.0 97.0 96.0 96.0 97.0 96.0 96.0 96.0 97.0 19:25:35 INFO - PROCESS | 6012 | 19:25:35 INFO - PROCESS | 6012 | [#8] json-parse-financial Cycles:10 Average:69.10 Median:69.00 stddev:2.13 (3.1%) stddev-sans-first:1.94 19:25:35 INFO - PROCESS | 6012 | Values: 66.0 69.0 69.0 67.0 68.0 70.0 70.0 74.0 69.0 69.0 19:25:35 INFO - PROCESS | 6012 | 19:25:35 INFO - PROCESS | 6012 | [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.74 (1.1%) stddev-sans-first:0.67 19:25:35 INFO - PROCESS | 6012 | Values: 69.0 67.0 68.0 68.0 68.0 68.0 67.0 67.0 69.0 68.0 19:25:35 INFO - PROCESS | 6012 | 19:25:35 INFO - PROCESS | 6012 | [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:85.50 stddev:2.41 (2.8%) stddev-sans-first:2.55 19:25:35 INFO - PROCESS | 6012 | Values: 85.0 85.0 86.0 86.0 84.0 92.0 84.0 84.0 86.0 84.0 19:25:35 INFO - PROCESS | 6012 | 19:25:35 INFO - PROCESS | 6012 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:140.50 stddev:17.22 (12.3%) stddev-sans-first:18.26 19:25:35 INFO - PROCESS | 6012 | Values: 146.0 136.0 149.0 135.0 138.0 143.0 136.0 137.0 192.0 137.0 19:25:35 INFO - PROCESS | 6012 | 19:25:35 INFO - PROCESS | 6012 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.00 Median:180.00 stddev:1.56 (0.9%) stddev-sans-first:1.22 19:25:35 INFO - PROCESS | 6012 | Values: 183.0 179.0 180.0 180.0 179.0 181.0 177.0 180.0 181.0 180.0 19:25:35 INFO - PROCESS | 6012 | 19:25:35 INFO - PROCESS | 6012 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.00 stddev:3.07 (4.4%) stddev-sans-first:3.26 19:25:35 INFO - PROCESS | 6012 | Values: 70.0 70.0 69.0 70.0 69.0 70.0 69.0 67.0 78.0 67.0 19:25:35 INFO - PROCESS | 6012 | -------- Summary: end -------- 19:25:35 INFO - PROCESS | 6012 | 19:25:36 INFO - TEST-INFO | 6012: exit 0 19:25:36 INFO - TEST-OK | kraken | took 64220ms 19:25:36 INFO - SUITE-END | took 1184s 19:25:36 INFO - Completed test suite (00:19:44) 19:25:36 INFO - javascript benchmark 19:25:36 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6344.084159680837, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2604.7004594471637, 2611.529924613571, 2612.947741045179, 2634.2624065261725, 2648.1393547097186, 4717.268823332381, 4784.497627749084, 4829.179039563274, 4829.541193586612, 4837.274408838676, 4734.218853889104, 4829.806807727687, 4833.009233107214, 4854.393200849894, 4924.3105965164905, 4341.044970106579, 4396.648268138541, 4412.735235885841, 4475.351074094255, 4513.323001549761, 4043.5349934757587, 4528.162289976365, 4532.614727748129, 4556.339330797033, 4558.566936141061, 4319.546447623017, 4451.577100175478, 4469.039156581318, 4491.30384790358, 4553.954460455403, 4355.956440435587, 4392.714473559208, 4418.248897687401, 4430.822767089313, 4433.733975961452, 4379.781010949471, 4387.188370151533, 4388.05656783793, 4389.078293558357, 4397.032652816375, 4665.346851440801, 4677.88305292367, 4707.599854012413, 4780.617550595944, 4789.185838407479, 5051.848444546669, 5055.4186268579215, 5056.696598204083, 5060.114479966028, 5144.9742751286, 5122.436531981479, 5130.256112863613, 5134.922976155361, 5138.203578445347, 5144.3312369392115, 4717.457492388419, 4750.762461876892, 4760.166970780169, 4804.927926081112, 4821.0, 5214.608904332114, 5224.843254702365, 5227.817026404057, 5230.0, 5267.525922666979, 4987.451380348159, 5004.299398084271, 5010.69935803853, 5019.974900125476, 5039.4708555601865, 4994.52552007566, 5049.469805670426, 5119.334486516729, 5119.564836988823, 5123.410807757155, 5062.443131255559, 5113.9744301279, 5150.4334523202415, 5185.092608793446, 5192.9740351298005, 5147.3308469898675, 5152.098382782998, 5153.175491921274, 5168.095583272912, 5203.817866374735, 4292.441982542249, 4337.934930976038, 4445.088756804847, 4461.620762235247, 4494.348319493721, 3762.2287431076566, 3765.548134223911, 3795.582485926546, 3802.296575133609, 3849.345611246039, 4425.845095421645, 4428.712133711363, 4429.867103986886, 4469.642428605704, 4472.127935052698, 5103.362079740033, 5136.948630513722, 5137.717425541631, 5166.9224961625605, 5167.328247327899, 4355.956440435619, 4380.277254253013, 4390.62679672225, 4436.955630443655, 4462.553744625577, 4620.768961551909, 4642.0715856828765, 4646.976765116153, 4649.488556258809, 4695.647826413033, 4773.498782627774, 4780.948191397887, 4797.112534181258, 4800.3759511263315, 4849.199882019428, 5018.0, 5052.292679024866, 5093.388793344674, 5155.845324640267, 5163.070647283525, 4804.25534042224, 4805.8077676892535, 4816.590589799906, 4854.441739200037, 4856.247281671346, 4928.950710492993, 4930.852074437773, 5000.67495612784, 5067.721275329893, 5080.034793389244, 5089.720065396439, 5138.717370544656, 5174.14626586609, 5208.635395522277, 5217.8173763918085, 4982.177940639899, 5040.873978150576, 5041.193409054534, 5041.773120209673, 5046.924296135488, 4810.927836082532, 4876.80492780299, 5019.0, 5029.06962211992, 5033.874153146201, 4823.975880120717, 4841.8547443576745, 4879.780409881493, 4882.316475693335, 4891.144049791344, 4931.235658472942, 4935.629827763004, 4965.751712414437, 4981.950180498148, 4982.875428114181, 4821.831235906867, 4822.083804077214, 4825.252085926687, 4860.708357498562, 4866.318715379921], "value": 4698.089441620905, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [516.4757770862574, 528.6114705691318, 532.7975369359643, 541.0180522351931, 554.0, 38523.0, 40427.978601069975, 40621.7968910155, 40641.39037914434, 40868.0, 40615.390769138416, 41450.792746036306, 41560.79219603898, 41648.0, 41799.37300940481, 7443.478956473049, 7676.923230767705, 7700.845983080335, 9437.339386242966, 9693.806123877519, 9507.667231646894, 9566.282528810332, 9574.904250957507, 9587.520623968809, 9602.279829012818, 9463.668771592995, 9600.279979001569, 9623.759406014835, 9624.374415662995, 9628.903710962872, 9530.666426675032, 9599.712008639752, 9603.375780574275, 9614.134727874454, 9622.123685881255, 9445.527723613792, 9447.196988255937, 9503.192228660571, 9514.571844267024, 9516.476593787338, 34545.48181777275, 34986.0, 35020.47469287963, 35105.0, 35124.0, 3405.3019131078067, 3426.2633533790104, 3450.413429716954, 3468.0809585459874, 3472.4791281307753, 25658.743412565822, 26172.8691356542, 26245.73754262452, 26259.73740262592, 26271.73728262712, 3425.828708564562, 3489.842957066938, 3551.5027896094566, 3690.409534474471, 3691.077230692327, 253634.0, 254031.0, 255297.0, 255359.0, 255994.0, 47756.7612161937, 47853.28220076702, 48118.0, 48216.27675584869, 48363.27455088177, 50244.74877625588, 50316.49683503118, 50442.495575044515, 50635.24047139296, 50766.492335076175, 13470.93264533671, 13688.589342319747, 13738.519151829638, 13739.24434156131, 13764.17414955106, 9078.228350590141, 9394.483303418241, 9996.150327222267, 10242.129418999468, 10401.063904248502, 15967.680646387007, 15993.520194394187, 15998.840011599968, 16091.114988675501, 16166.67666646684, 6533.967330163414, 6565.376289252609, 6677.599344039373, 6698.765543205965, 6806.42145417645, 805.3315747929205, 811.1563973467646, 818.439369032203, 832.7252006837729, 840.8696652018947, 27857.860710696317, 28047.71952280492, 28291.0, 28412.0, 28525.0, 925.2135684667978, 933.1321870660352, 946.4747065378781, 957.6313119449062, 968.1528662420383, 14011.649708757363, 14941.327640256215, 14946.973429482907, 14970.0, 15246.923765381323, 353925.0, 357973.0, 358099.0, 358580.0, 358806.0, 51090.23364649533, 51448.48551514437, 51548.22677659838, 51584.0, 51780.741096294274, 1168.8831214448223, 1199.7300607363447, 1210.5460452330376, 1219.8719134490927, 1254.0782524844233, 25919.740802591732, 26833.0, 27511.31221719473, 27973.0, 29289.414211716074, 48794.0, 49717.0, 53456.46543534515, 53982.19026714681, 54016.0, 336001.0, 346382.0, 346713.0, 347313.0, 348184.0, 39927.600723992386, 40271.19457610773, 40797.0, 41194.38208426936, 43487.347689784045, 43951.340729889715, 44283.0, 44301.33547996847, 44658.77670611626, 45693.31460028169, 35497.645023549434, 37627.43558846565, 37627.75054098815, 39174.0, 40006.59993400029, 38730.0, 38832.80583597064, 39395.2120957585, 39690.40464393094, 39813.800930996316, 36402.27195456129, 36939.44590831086, 37798.81100594479, 37995.620043800314, 38923.41614875723, 32421.837890810395, 34817.825910870284, 34833.0, 35227.0, 35349.82325088358, 26470.338241544116, 26542.734572654026, 26674.59988100219, 26838.731612683623, 27140.185794426197], "value": 18158.285957329437, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.64794121613846, 369.9260147970406, 375.4349703695937, 380.0517708317748, 392.54856914548265, 17096.230669619865, 18495.81504184958, 18567.350142745006, 19044.333448329293, 19165.32921347753, 17881.374151904685, 18067.36764213253, 18264.543386415346, 18370.540736481595, 18418.26326946924, 5020.7489625518665, 5214.661047031931, 5222.268882356473, 5233.371995360562, 5237.188235823453, 4945.159322915113, 5097.5921926246, 5149.40781810091, 5157.432682404932, 5168.043911876296, 5134.383873935133, 5143.27994080829, 5144.922826157611, 5149.459306772791, 5156.123459011958, 5099.949000510003, 5349.197620356938, 5607.327120745516, 5649.180868774005, 5657.462541058593, 5417.83746487606, 5474.863128421782, 5479.561635069185, 5485.6982865942355, 5510.6969116698565, 12114.939425302906, 15928.442504512286, 20027.79972200274, 20932.0, 21015.894920525454, 2141.753698324697, 2151.9139234430604, 2206.3050139206257, 2243.3270018994235, 2277.806386457153, 9215.0, 9293.907060929372, 9314.767130821716, 9578.185854202402, 9802.166815820663, 1680.3868286445027, 1748.0997286397514, 1768.823117688221, 1775.3874913154941, 1777.79555351135, 73564.2643573568, 74473.0, 74688.62655686741, 74790.62604686996, 76729.84905226482, 9624.855627165598, 9804.901950980542, 9836.213102951746, 9969.601215951281, 10542.0, 13421.530246441327, 13425.530106446227, 13425.731485370237, 13429.127106738226, 13453.0, 6597.8350541235895, 6764.594124352555, 6818.93181068183, 6846.075779769667, 6918.861622767517, 6347.650879201596, 6349.936500635027, 6440.645764482904, 6491.578047426902, 6565.573237739532, 4054.270231358325, 4093.815778289984, 4100.671946244293, 4152.626263636287, 4260.552641972548, 1840.190316260841, 1855.1466325490155, 1861.2089861808677, 1899.4396652987402, 1901.9714704279447, 817.4890693316677, 833.2251006563954, 833.5290560833109, 834.8497270491248, 837.4682076881224, 16665.41671041532, 17330.82669173292, 18503.444896653124, 18528.351507697436, 18606.627867442847, 825.1212458731432, 844.6705784743955, 848.0205362805968, 849.834282314955, 852.0882655558617, 9485.715428537154, 10052.346597471142, 10163.4918254087, 10186.745331366626, 10193.74515637115, 483032.0, 487779.0, 491634.0, 530785.0, 544981.0, 89562.0, 89610.55194723984, 91879.08120918839, 92043.99999999866, 92275.53862230646, 908.9772755681029, 918.4672889724078, 929.2519521784893, 932.1005229953128, 935.0649350649351, 16240.593985150466, 16789.0, 16896.57758556046, 16984.745228821826, 17352.273749662832, 37279.81360093182, 41310.79344603258, 41698.79150604349, 42104.78947605365, 45185.32222016607, 56224.71887640536, 57355.42644573668, 57690.0, 58083.128753069584, 59273.407265928516, 5398.676079435247, 6024.337322894566, 7556.2443755624, 7959.641816118173, 8038.919610803817, 8635.568221589021, 9158.992510823671, 9383.812323753351, 12849.743005139659, 13117.34413279313, 10431.321964072311, 10450.529726162493, 10472.109870660774, 10641.946790266, 11278.0, 10340.741481463023, 10588.576456941637, 10882.020618144405, 10901.400422976496, 11392.886071139183, 5694.943050569441, 8211.548364839991, 10473.26687131924, 10957.232993690364, 11297.43512824372, 7661.923380766121, 7718.691252349843, 7725.884111738216, 7782.649780759766, 8039.316658083894, 7838.490498117832, 9625.229981601595, 10270.33242839213, 10788.784224315626, 10795.6221532246], "value": 8354.185994714731, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1276.1194775604831, 1298.4806077568974, 1307.725377670689, 1310.50200923649, 1315.4475120449413, 6124.265088189412, 6318.210223722035, 6673.0, 7098.716051357946, 7100.147982242125, 6652.434543063845, 6878.587284762918, 6941.652917354125, 6995.0, 7072.328128827766, 2065.6075345684308, 2101.117530637136, 2102.1801497415945, 2102.7686954435076, 2108.652072408051, 1691.6954948109335, 1748.8863223890407, 1915.329634627883, 1983.3058429549615, 1989.0850208903921, 1995.650761116806, 2070.0891607692565, 2075.0765909170427, 2081.5004398944297, 2084.3434318189798, 2012.1247257443058, 2031.837453003756, 2042.6527490326532, 2049.467138543982, 2056.7531896172554, 2012.748406449194, 2035.4809523571394, 2049.2008116834445, 2053.5276886316083, 2084.749830020392, 6964.651767411609, 6966.4078553323025, 6986.231514533448, 7014.193367762721, 7016.333448322402, 4062.6343629073526, 4158.563350848148, 4167.291560434734, 4203.55862634422, 4206.705530612859, 2564.1794625719776, 2665.315127303077, 2750.477409292228, 2760.8619569021466, 2780.4856101621062, 1104.828751543512, 1108.6673997800708, 1118.7538741476862, 1140.7604403075363, 1150.8618965724083, 9184.0, 9205.401648892801, 9222.584983675752, 9224.07759224079, 9242.306826988002, 3748.6438788315068, 3851.9422208666892, 3890.4553362528704, 3931.8820435386983, 3948.980255098706, 7898.605069746604, 7923.7226697065325, 7930.801729956682, 7951.801204969922, 7952.32405245549, 4231.4710661167355, 4307.396964424983, 4311.0300182458695, 4322.848700295474, 4327.0, 3848.3265428549894, 3965.9008524786536, 3975.0658595230097, 3976.4234186042863, 3982.681385489154, 3332.216929021678, 3356.0435275946725, 3423.281110966675, 3432.2792213634916, 3526.3828829954655, 1018.0582960761266, 1052.7315534538798, 1093.2456604942565, 1126.318577260762, 1128.136975213962, 712.5404114346218, 733.7835338575027, 740.8555331710372, 747.5215861848421, 818.5211651184125, 4616.60758835496, 4772.3557319762085, 4780.306855506002, 4876.829310974099, 4952.603791696655, 929.0987741890491, 934.462683956714, 943.2265542255285, 944.6552008516842, 963.5278713430368, 3256.690614391629, 3409.9488507672404, 3448.8620455181513, 3500.7199424046016, 3502.1419752160373, 7592.696292148252, 7938.603069846485, 8010.158933312035, 8058.073321568095, 8134.715284965117, 7951.522908625501, 8022.79943001418, 8034.116247212802, 8040.075391330072, 8054.919450805534, 6296.905546416808, 6359.300476947532, 6385.680715964276, 6437.903431448532, 6506.284308726036, 4740.194166991689, 4741.596964258077, 4754.31062495943, 4851.434195866106, 4939.777710003131, 7402.518836275625, 7464.664090115849, 7491.063617047869, 7524.811879703051, 7545.471816972979, 7503.2496750324535, 7516.5114267572435, 7565.130010048915, 7630.542167469969, 7693.923060769321, 5966.105084237399, 6022.668753218615, 6033.758649653964, 6035.486983606443, 6043.033114701627, 6478.2550006749825, 6541.738330466728, 6546.24718157418, 6553.639549824615, 6556.409923106943, 5279.89440211186, 5867.383924687846, 6000.129981152796, 6109.7861574844665, 6121.510279177566, 5727.198192253005, 5827.125931110368, 5827.388124246893, 5845.3570107289015, 5953.732082056231, 5204.557612602971, 5394.595405344693, 5453.454654534515, 5457.754401052041, 5565.638233514808, 4143.544210136823, 4153.293940030142, 4238.660907127484, 4248.787560622019, 4348.8043038064, 4299.161663475717, 4369.431973843507, 4379.408779814812, 4427.402300689366, 4492.707973981812], "value": 3769.6498070567472, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.9250918543328, 337.3506000948176, 337.6370401818046, 339.5992728580274, 342.13439996808086, 4961.900761984758, 4979.975100124503, 5034.899302013962, 5043.998820701686, 5052.393712754465, 4956.942868709481, 4977.502249775021, 4998.150314446544, 4999.875003124915, 5039.596832253411, 3727.7390582659223, 3817.656410923016, 3834.5015148030716, 3863.594322596129, 4034.2133284009556, 3843.4811300474357, 3875.205582855508, 3882.165334453092, 3884.4561761353434, 3899.337112690835, 3844.6539811416965, 3851.919963219858, 3860.0, 3867.5939026402243, 3871.59348268432, 3731.328360895038, 3858.614138586147, 3859.5140870764676, 3867.149227170018, 3871.49670542829, 3335.2495688470144, 3347.09628400333, 3366.7138293245102, 3378.121688361019, 3379.3410284994434, 4883.438404583483, 4919.77860996256, 4923.359963204761, 4944.851654450372, 4956.405231372222, 4414.984553552701, 4427.490838553543, 4436.93344599828, 4451.399061126739, 4453.153900758845, 5008.699478031293, 5178.870528236786, 5240.213967904807, 5274.525292723673, 5312.867178320535, 3680.2087551176623, 3688.981555092234, 3696.094456858087, 3713.294474049922, 3713.5543734752005, 5477.260569823103, 5477.726113694339, 5496.972515137439, 5527.397054854087, 5528.0, 3662.5788034375855, 3743.232637309345, 3747.550293964687, 3749.0, 3762.830672619739, 3772.679322257584, 3797.5063241778394, 3803.5625903020955, 3810.142717888453, 3822.961770382316, 4364.672649551297, 4405.713628614129, 4412.947979189692, 4413.256763578369, 4450.310201918708, 5111.693298402108, 5322.023907646363, 5334.546563542065, 5346.599005074635, 5373.952079344568, 1259.4962015193812, 1259.7165637731437, 1269.990357665658, 1279.3858947705153, 1281.3657239666425, 838.2916435611899, 857.7941294089374, 865.6234537976001, 868.7524055644111, 871.9956400217958, 4390.073400908747, 4407.515173330931, 4460.7323560586465, 4642.1644104060915, 4654.4414670239785, 5458.372287187024, 5462.317210348707, 5469.714617064987, 5480.588955828329, 5484.972575137179, 4614.7461889595725, 4636.420447444069, 4647.16351056813, 4648.767561621906, 4659.58063774262, 2724.1555117913113, 2792.3577577157366, 2802.607634931111, 2809.2134202423354, 2814.4230432761233, 4877.195262781673, 4895.412550493892, 4895.632827537877, 4903.779329930162, 4929.852104436873, 5392.514673679388, 5417.853039612305, 5426.097038084606, 5429.267048948421, 5453.0, 4663.930041049387, 4889.951100488949, 4919.532644398776, 4934.605231581393, 4963.230699241623, 5277.815276465459, 5324.124972514798, 5347.331583552056, 5359.383670877899, 5367.194920761917, 4947.208446648519, 5209.791608335776, 5213.6350455467755, 5217.843464696065, 5229.973850130725, 4832.830850920201, 4860.222364421676, 4860.95139048605, 4875.90248195027, 4899.975500122477, 3630.3283892479976, 3646.6717995380545, 3663.413853783382, 3665.17533554948, 3668.8715894944617, 5252.868678283074, 5294.0, 5301.628885977944, 5306.7098398992875, 5310.468953104659, 4934.284528743384, 5239.004589128053, 5263.315708988367, 5264.341957255343, 5273.34083239595, 5231.267622532772, 5235.712035838065, 5266.9736651318035, 5267.6813607427075, 5273.024490469275, 4978.4274808397495, 5156.896862062813, 5156.948430515647, 5178.43037265908, 5187.273781670645, 5166.586673066221, 5272.525472707474, 5301.496357845998, 5337.599680023936, 5351.441291541238, 5105.668131571436, 5162.328897243335, 5183.3261675981885, 5184.533391994739, 5208.921866172086], "value": 3914.76340883248, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.3172963577155, 690.8031211104833, 735.1802739944962, 759.5556599389357, 792.5601291283338, 11000.449977501123, 11836.7632647347, 11848.763024739521, 11849.229800063, 11850.170488065838, 11394.316341019545, 11430.485628146733, 11449.656510304683, 11466.08271338293, 11580.59467918623, 654.3816093791369, 673.1551902362528, 778.3423007558604, 793.2266040610402, 796.3111908199423, 789.7551758954743, 808.640155130964, 809.9635516401776, 811.2009670474578, 811.5860910935436, 855.6491838346279, 858.1375717404001, 859.1966511311944, 859.866720658299, 859.8882145321131, 848.9108643592426, 850.2900078434515, 850.6257246811414, 851.0085750101125, 851.953142577158, 623.7286780250605, 625.8404106952744, 626.7117126121989, 627.5356236385088, 629.1443636654146, 11617.361045142514, 11893.40532973348, 12207.084468664885, 12324.753504929851, 12329.69175770604, 13587.796183057262, 14294.499692510712, 14320.785188222186, 14424.423023079064, 14510.347034383478, 9848.753781155528, 10075.798484030352, 10097.899021009769, 10124.645637402655, 10283.691489255334, 3312.8840490582716, 3335.28291417344, 3337.1156643489494, 3382.52644629752, 3404.2510647657477, 66666.3333366665, 67921.320786792, 69017.30982690159, 69673.0, 70606.94089588609, 10783.892161078289, 10801.567937282578, 10866.402347870784, 10894.128469722404, 10995.34027958325, 20611.69082463764, 20756.06597703107, 20773.67621180604, 20877.164913403598, 20964.685529717066, 6838.247792742794, 6970.512064155562, 7070.611116388648, 7152.713891444388, 7227.457940654472, 3697.4084146536425, 3718.5165928429133, 3722.4788529605876, 3727.7576957497677, 3738.6635202831876, 2799.5520716685232, 2831.3063299491755, 2849.344650730344, 2859.914202573926, 2876.2090425133256, 470.04346155573245, 475.1447394689614, 478.4450037955954, 487.46865916151563, 487.76831005272214, 628.8836565235446, 630.6606518484634, 641.8170821315996, 644.6831054225981, 660.7654282729658, 8076.434649574473, 8089.312408445348, 8265.5691194982, 8305.501669899826, 8511.106333834858, 635.2599221906427, 637.9425851673371, 642.7750287399373, 643.3662842100528, 644.407145426209, 3875.302445559826, 3894.3768996960353, 3969.4045893116263, 3999.3601023836045, 4036.798160091984, 68871.96692049623, 69999.0, 71116.0, 71657.2834271661, 73334.63332683302, 60561.0, 60590.39409605935, 60758.69620651868, 60787.69606151941, 61088.0, 41360.37959430611, 51200.48799512032, 52552.21171682428, 53019.20471192935, 53143.73428132835, 7355.926440735524, 7561.281678240558, 7696.0, 7843.450958432855, 7881.330086942674, 30383.2599558733, 30451.39097217999, 33805.32389352249, 34851.25743712753, 36085.45871811977, 39162.608373917035, 42413.0, 48082.0, 48678.0, 48744.512554873996, 9158.862617060882, 9338.486383248986, 9343.672971445967, 9555.426674399558, 9653.420794752337, 11077.446127693422, 11186.888131118585, 11242.718932026764, 11287.943560282147, 11982.400879955792, 10216.693499195037, 10269.691909242734, 10310.793784124426, 10359.792804144026, 10362.0, 10059.28399332191, 10062.446565438971, 10079.0, 10268.897311026794, 10343.482825858828, 10125.898741012496, 10444.947775261075, 10760.300580462244, 11299.943500282447, 11400.144989125683, 9274.629014839331, 9711.805763884824, 9736.902630973884, 9813.656522021694, 10014.799704005733, 9571.808563828823, 9657.372270802376, 9739.123478886933, 9753.268504862306, 9761.951190244003], "value": 6198.02055325691, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1579.4000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 118.0, 120.0, 116.0, 115.0, 116.0, 117.0, 117.0, 117.0, 117.0], "value": 116.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 125.0, 126.0, 160.0, 126.0, 141.0, 133.0, 128.0, 162.0, 131.0], "value": 138.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 173.0, 164.0, 163.0, 162.0, 163.0, 163.0, 163.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 79.0, 113.0, 80.0, 81.0, 78.0, 82.0, 92.0, 77.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 116.0, 86.0, 86.0, 85.0, 112.0, 86.0, 85.0, 108.0], "value": 93.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 118.0, 119.0, 122.0, 118.0, 118.0, 118.0, 118.0, 119.0], "value": 118.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 150.0, 150.0, 151.0, 151.0, 152.0, 151.0, 151.0, 151.0, 150.0], "value": 150.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 97.0], "value": 96.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 69.0, 67.0, 68.0, 70.0, 70.0, 74.0, 69.0, 69.0], "value": 69.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 67.0, 68.0, 68.0, 68.0, 68.0, 67.0, 67.0, 69.0, 68.0], "value": 67.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 86.0, 86.0, 84.0, 92.0, 84.0, 84.0, 86.0, 84.0], "value": 85.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 136.0, 149.0, 135.0, 138.0, 143.0, 136.0, 137.0, 192.0, 137.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 179.0, 180.0, 180.0, 179.0, 181.0, 177.0, 180.0, 181.0, 180.0], "value": 180.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 70.0, 69.0, 70.0, 69.0, 67.0, 78.0, 67.0], "value": 69.9, "unit": "score"}]}]} 19:25:36 INFO - Return code: 0 19:25:36 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:25:36 ERROR - # TBPL SUCCESS # 19:25:36 INFO - Running post-action listener: _resource_record_post_action 19:25:36 INFO - [mozharness: 2017-01-05 03:25:36.853595Z] Finished run-tests step (success) 19:25:36 INFO - Running post-run listener: _resource_record_post_run 19:25:36 INFO - Total resource usage - Wall time: 1200s; CPU: 14.0%; Read bytes: 4096; Write bytes: 383221760; Read time: 8; Write time: 256876 19:25:36 INFO - TinderboxPrint: CPU usage
13.5% 19:25:36 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 19:25:36 INFO - TinderboxPrint: I/O write bytes / time
383,221,760 / 256,876 19:25:36 INFO - TinderboxPrint: CPU idle
8,278.5 (86.5%) 19:25:36 INFO - TinderboxPrint: CPU user
1,235.0 (12.9%) 19:25:36 INFO - TinderboxPrint: Swap in / out
0 / 0 19:25:36 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99094528; Read time: 0; Write time: 57188 19:25:36 INFO - run-tests - Wall time: 1185s; CPU: 14.0%; Read bytes: 0; Write bytes: 282984448; Read time: 0; Write time: 199640 19:25:37 INFO - Running post-run listener: _upload_blobber_files 19:25:37 INFO - Blob upload gear active. 19:25:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:25:37 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 19:25:37 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'] 19:25:37 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 19:25:37 INFO - (blobuploader) - INFO - Open directory for files ... 19:25:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:25:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:25:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:41 INFO - (blobuploader) - INFO - Done attempting. 19:25:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:25:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:25:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:42 INFO - (blobuploader) - INFO - Done attempting. 19:25:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:25:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:25:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:43 INFO - (blobuploader) - INFO - Done attempting. 19:25:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:25:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:25:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:25:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:25:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:25:44 INFO - (blobuploader) - INFO - Done attempting. 19:25:44 INFO - (blobuploader) - INFO - Iteration through files over. 19:25:44 INFO - Return code: 0 19:25:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:25:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:25:44 INFO - Setting buildbot property blobber_files to {"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e9b39ccfc35f2235b27f4170a721885bf1067909c7c9953238e7e7b24ff83a299ccc0da2f3b832ac80c79c790dac03ce548d6f96ff4885790c55a69b25388403", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/618e7b4a35c87385404224ae7c447629167ec2c68d25314f777c0560cb7ebd4768c91979e83df6190f1d010103ddcc8b841ebc81609dc17c5920030ad8edd285", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/09b5160e41a19c8ea05d29fdb1a4547dda628fd459e6651600e0c852a3e01a3832941c875d4172766603c844a97dfd1a4eb666ce44dea288a283e7d6a26b731f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/37e0e36b8e61dfa59fbc08e7afb6cb8560f2b48a200feba270cee950e4842b111e486a1e5b22c138529fcfe7b337b176746d50cdcd4074c01728d20b5ba1a61a"} 19:25:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:25:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:25:44 INFO - Contents: 19:25:44 INFO - blobber_files:{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e9b39ccfc35f2235b27f4170a721885bf1067909c7c9953238e7e7b24ff83a299ccc0da2f3b832ac80c79c790dac03ce548d6f96ff4885790c55a69b25388403", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/618e7b4a35c87385404224ae7c447629167ec2c68d25314f777c0560cb7ebd4768c91979e83df6190f1d010103ddcc8b841ebc81609dc17c5920030ad8edd285", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/09b5160e41a19c8ea05d29fdb1a4547dda628fd459e6651600e0c852a3e01a3832941c875d4172766603c844a97dfd1a4eb666ce44dea288a283e7d6a26b731f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/37e0e36b8e61dfa59fbc08e7afb6cb8560f2b48a200feba270cee950e4842b111e486a1e5b22c138529fcfe7b337b176746d50cdcd4074c01728d20b5ba1a61a"} 19:25:44 INFO - Running post-run listener: copy_logs_to_upload_dir 19:25:44 INFO - Copying logs to upload dir... 19:25:44 INFO - mkdir: /builds/slave/test/build/upload/logs 19:25:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.839076 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2017-01-04 19:25:43.893632) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-04 19:25:43.897535) ========= 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=cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077 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/e9b39ccfc35f2235b27f4170a721885bf1067909c7c9953238e7e7b24ff83a299ccc0da2f3b832ac80c79c790dac03ce548d6f96ff4885790c55a69b25388403", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/618e7b4a35c87385404224ae7c447629167ec2c68d25314f777c0560cb7ebd4768c91979e83df6190f1d010103ddcc8b841ebc81609dc17c5920030ad8edd285", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/09b5160e41a19c8ea05d29fdb1a4547dda628fd459e6651600e0c852a3e01a3832941c875d4172766603c844a97dfd1a4eb666ce44dea288a283e7d6a26b731f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/37e0e36b8e61dfa59fbc08e7afb6cb8560f2b48a200feba270cee950e4842b111e486a1e5b22c138529fcfe7b337b176746d50cdcd4074c01728d20b5ba1a61a"} build_url:https://queue.taskcluster.net/v1/task/f5Ky-r_QQvOycseDCgcSlA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011591 build_url: 'https://queue.taskcluster.net/v1/task/f5Ky-r_QQvOycseDCgcSlA/artifacts/public/build/target.tar.bz2' blobber_files: '{"perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e9b39ccfc35f2235b27f4170a721885bf1067909c7c9953238e7e7b24ff83a299ccc0da2f3b832ac80c79c790dac03ce548d6f96ff4885790c55a69b25388403", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/618e7b4a35c87385404224ae7c447629167ec2c68d25314f777c0560cb7ebd4768c91979e83df6190f1d010103ddcc8b841ebc81609dc17c5920030ad8edd285", "dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/09b5160e41a19c8ea05d29fdb1a4547dda628fd459e6651600e0c852a3e01a3832941c875d4172766603c844a97dfd1a4eb666ce44dea288a283e7d6a26b731f", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/37e0e36b8e61dfa59fbc08e7afb6cb8560f2b48a200feba270cee950e4842b111e486a1e5b22c138529fcfe7b337b176746d50cdcd4074c01728d20b5ba1a61a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-04 19:25:43.922769) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 19:25:43.923075) ========= 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=cbe409c6de289db6ac707de3000001d4-1483585448.990616-1941137077 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004491 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 19:25:44.006899) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-04 19:25:44.007216) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-04 19:25:44.007503) ========= ========= Total master_lag: 0.16 =========