builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-035 starttime: 1483544326.04 results: success (0) revision: a2741dd43eeae54f4dd7423bd832a761481c56ce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-04 07:38:46.035866) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-04 07:38:46.036307) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-04 07:38:46.036597) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-04 07:38:46.052478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 07:38:46.052858) ========= 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=ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-04 07:38:46-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.0M=0s 2017-01-04 07:38:47 (46.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.113740 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 07:38:46.180234) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 07:38:46.180559) ========= 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=ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015272 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 07:38:46.230347) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-04 07:38:46.230688) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev a2741dd43eeae54f4dd7423bd832a761481c56ce --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 a2741dd43eeae54f4dd7423bd832a761481c56ce --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=ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-04 07:38:47,181 truncating revision to first 12 chars 2017-01-04 07:38:47,181 Setting DEBUG logging. 2017-01-04 07:38:47,181 attempt 1/10 2017-01-04 07:38:47,181 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/a2741dd43eea?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-04 07:38:47,802 unpacking tar archive at: mozilla-central-a2741dd43eea/testing/mozharness/ program finished with exit code 0 elapsedTime=1.009965 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-04 07:38:47.253697) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-04 07:38:47.254047) ========= script_repo_revision: a2741dd43eeae54f4dd7423bd832a761481c56ce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-04 07:38:47.254415) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-04 07:38:47.254698) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-04 07:38:47.263873) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-01-04 07:38:47.264156) ========= /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=ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:38:48 INFO - MultiFileLogger online at 20170104 07:38:48 in /builds/slave/test 07:38:48 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 07:38:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:38:48 INFO - {'append_to_log': False, 07:38:48 INFO - 'base_work_dir': '/builds/slave/test', 07:38:48 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:38:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:38:48 INFO - 'branch': 'Firefox-Non-PGO', 07:38:48 INFO - 'buildbot_json_path': 'buildprops.json', 07:38:48 INFO - 'config_files': ('talos/linux_config.py',), 07:38:48 INFO - 'default_actions': ('clobber', 07:38:48 INFO - 'read-buildbot-config', 07:38:48 INFO - 'download-and-extract', 07:38:48 INFO - 'populate-webroot', 07:38:48 INFO - 'create-virtualenv', 07:38:48 INFO - 'install', 07:38:48 INFO - 'run-tests'), 07:38:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:38:48 INFO - 'download_minidump_stackwalk': True, 07:38:48 INFO - 'download_symbols': 'ondemand', 07:38:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:38:48 INFO - 'tooltool.py': '/tools/tooltool.py', 07:38:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:38:48 INFO - '/tools/misc-python/virtualenv.py')}, 07:38:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:38:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:38:48 INFO - 'installer_path': 'installer.exe', 07:38:48 INFO - 'log_level': 'info', 07:38:48 INFO - 'log_name': 'talos', 07:38:48 INFO - 'log_to_console': True, 07:38:48 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:38:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:38:48 INFO - 'opt_config_files': (), 07:38:48 INFO - 'pip_index': False, 07:38:48 INFO - 'sps_profile': False, 07:38:48 INFO - 'sps_profile_interval': 0, 07:38:48 INFO - 'suite': 'dromaeojs-e10s', 07:38:48 INFO - 'system_bits': '32', 07:38:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:38:48 INFO - 'title': 'talos-linux64-ix-035', 07:38:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:38:48 INFO - 'use_talos_json': True, 07:38:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:38:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:38:48 INFO - 'work_dir': 'build'} 07:38:48 INFO - [mozharness: 2017-01-04 15:38:48.315015Z] Running clobber step. 07:38:48 INFO - Running pre-action listener: _resource_record_pre_action 07:38:48 INFO - Running main action method: clobber 07:38:48 INFO - rmtree: /builds/slave/test/build 07:38:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:38:49 INFO - Running post-action listener: _resource_record_post_action 07:38:49 INFO - [mozharness: 2017-01-04 15:38:49.285167Z] Finished clobber step (success) 07:38:49 INFO - [mozharness: 2017-01-04 15:38:49.285266Z] Running read-buildbot-config step. 07:38:49 INFO - Running pre-action listener: _resource_record_pre_action 07:38:49 INFO - Running main action method: read_buildbot_config 07:38:49 INFO - Using buildbot properties: 07:38:49 INFO - { 07:38:49 INFO - "project": "", 07:38:49 INFO - "product": "firefox", 07:38:49 INFO - "who": "cbook@mozilla.com", 07:38:49 INFO - "installer_path": "public/build/target.tar.bz2", 07:38:49 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:38:49 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:38:49 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:38:49 INFO - "stage_platform": "linux64", 07:38:49 INFO - "basedir": "/builds/slave/test", 07:38:49 INFO - "buildnumber": 627, 07:38:49 INFO - "platform": "ubuntu64_hw", 07:38:49 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:38:49 INFO - "slavebuilddir": "test", 07:38:49 INFO - "taskId": "ODAtlZmkQ5-DAANTF-Oxew", 07:38:49 INFO - "branch": "mozilla-central", 07:38:49 INFO - "script_repo_revision": "production", 07:38:49 INFO - "revision": "a2741dd43eeae54f4dd7423bd832a761481c56ce", 07:38:49 INFO - "slavename": "talos-linux64-ix-035", 07:38:49 INFO - "repo_path": "mozilla-central" 07:38:49 INFO - } 07:38:49 INFO - Finding installer, test and symbols from parent task. 07:38:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ODAtlZmkQ5-DAANTF-Oxew'}, attempt #1 07:38:49 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ODAtlZmkQ5-DAANTF-Oxew'}, attempt #1 07:38:50 INFO - Task dependencies: MLNBNqopQE2dS_AxiBPXDA 07:38:50 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MLNBNqopQE2dS_AxiBPXDA'}, attempt #1 07:38:50 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/MLNBNqopQE2dS_AxiBPXDA/artifacts/public/build/target.tar.bz2 07:38:50 INFO - Set test_url: https://queue.taskcluster.net/v1/task/MLNBNqopQE2dS_AxiBPXDA/artifacts/public/build/test_packages.json 07:38:50 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/MLNBNqopQE2dS_AxiBPXDA/artifacts/public/build/target.crashreporter-symbols.zip 07:38:50 INFO - Running post-action listener: _resource_record_post_action 07:38:50 INFO - [mozharness: 2017-01-04 15:38:50.690416Z] Finished read-buildbot-config step (success) 07:38:50 INFO - [mozharness: 2017-01-04 15:38:50.690634Z] Running download-and-extract step. 07:38:50 INFO - Running pre-action listener: _resource_record_pre_action 07:38:50 INFO - Running main action method: download_and_extract 07:38:50 INFO - mkdir: /builds/slave/test/build/tests 07:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:38:50 INFO - trying https://queue.taskcluster.net/v1/task/MLNBNqopQE2dS_AxiBPXDA/artifacts/public/build/target.test_packages.json 07:38:50 INFO - Downloading https://queue.taskcluster.net/v1/task/MLNBNqopQE2dS_AxiBPXDA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:38:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MLNBNqopQE2dS_AxiBPXDA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:38:51 INFO - Downloaded 896 bytes. 07:38:51 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:38:51 INFO - Using the following test package requirements: 07:38:51 INFO - {u'common': [u'target.common.tests.zip'], 07:38:51 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:38:51 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:38:51 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:38:51 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:38:51 INFO - u'mozbase': [u'target.common.tests.zip'], 07:38:51 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:38:51 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:38:51 INFO - u'web-platform': [u'target.common.tests.zip', 07:38:51 INFO - u'target.web-platform.tests.zip'], 07:38:51 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:38:51 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:38:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MLNBNqopQE2dS_AxiBPXDA/artifacts/public/build/target.common.tests.zip 07:38:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MLNBNqopQE2dS_AxiBPXDA/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:38:51 INFO - Fetch https://queue.taskcluster.net/v1/task/MLNBNqopQE2dS_AxiBPXDA/artifacts/public/build/target.common.tests.zip into memory 07:38:53 INFO - Expected file size: 20244966 07:38:53 INFO - Obtained file size: 20244966 07:38:57 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:38:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MLNBNqopQE2dS_AxiBPXDA/artifacts/public/build/target.common.tests.zip 07:38:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MLNBNqopQE2dS_AxiBPXDA/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:38:57 INFO - Fetch https://queue.taskcluster.net/v1/task/MLNBNqopQE2dS_AxiBPXDA/artifacts/public/build/target.common.tests.zip into memory 07:38:57 INFO - Expected file size: 20244966 07:38:57 INFO - Obtained file size: 20244966 07:39:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MLNBNqopQE2dS_AxiBPXDA/artifacts/public/build/target.talos.tests.zip 07:39:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MLNBNqopQE2dS_AxiBPXDA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:39:02 INFO - Fetch https://queue.taskcluster.net/v1/task/MLNBNqopQE2dS_AxiBPXDA/artifacts/public/build/target.talos.tests.zip into memory 07:39:03 INFO - Expected file size: 14403730 07:39:03 INFO - Obtained file size: 14403730 07:39:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:39:04 INFO - trying https://queue.taskcluster.net/v1/task/MLNBNqopQE2dS_AxiBPXDA/artifacts/public/build/target.tar.bz2 07:39:04 INFO - Downloading https://queue.taskcluster.net/v1/task/MLNBNqopQE2dS_AxiBPXDA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:39:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MLNBNqopQE2dS_AxiBPXDA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:39:06 INFO - Downloaded 55870002 bytes. 07:39:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MLNBNqopQE2dS_AxiBPXDA/artifacts/public/build/target.tar.bz2 07:39:06 INFO - mkdir: /builds/slave/test/properties 07:39:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:39:06 INFO - Writing to file /builds/slave/test/properties/build_url 07:39:06 INFO - Contents: 07:39:06 INFO - build_url:https://queue.taskcluster.net/v1/task/MLNBNqopQE2dS_AxiBPXDA/artifacts/public/build/target.tar.bz2 07:39:06 INFO - Running post-action listener: _resource_record_post_action 07:39:06 INFO - Running post-action listener: set_extra_try_arguments 07:39:06 INFO - [mozharness: 2017-01-04 15:39:06.624022Z] Finished download-and-extract step (success) 07:39:06 INFO - [mozharness: 2017-01-04 15:39:06.624165Z] Running populate-webroot step. 07:39:06 INFO - Running pre-action listener: _resource_record_pre_action 07:39:06 INFO - Running main action method: populate_webroot 07:39:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:39:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:39:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:39:06 INFO - '--tppagecycles', 07:39:06 INFO - '7'], 07:39:06 INFO - 'tests': ['tsvgm']}}, 07:39:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:39:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:39:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:39:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:39:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:39:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:39:06 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:39:06 INFO - 'talos_options': ['--disable-e10s'], 07:39:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:39:06 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:39:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:39:06 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:39:06 INFO - 'talos_options': ['--disable-e10s'], 07:39:06 INFO - 'tests': ['damp', 'tps']}, 07:39:06 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:39:06 INFO - 'tests': ['damp', 'tps']}, 07:39:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:39:06 INFO - 'tests': ['dromaeo_dom']}, 07:39:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:39:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:39:06 INFO - 'tests': ['basic_compositor_video']}, 07:39:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:39:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:39:06 INFO - 'tests': ['a11yr', 07:39:06 INFO - 'ts_paint', 07:39:06 INFO - 'tpaint', 07:39:06 INFO - 'sessionrestore', 07:39:06 INFO - 'sessionrestore_no_auto_restore', 07:39:06 INFO - 'tabpaint']}, 07:39:06 INFO - 'other-e10s': {'tests': ['a11yr', 07:39:06 INFO - 'ts_paint', 07:39:06 INFO - 'tpaint', 07:39:06 INFO - 'sessionrestore', 07:39:06 INFO - 'sessionrestore_no_auto_restore', 07:39:06 INFO - 'tabpaint']}, 07:39:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:39:06 INFO - 'ts_paint', 07:39:06 INFO - 'tpaint', 07:39:06 INFO - 'sessionrestore', 07:39:06 INFO - 'sessionrestore_no_auto_restore', 07:39:06 INFO - 'tabpaint']}, 07:39:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:39:06 INFO - 'ts_paint', 07:39:06 INFO - 'tpaint', 07:39:06 INFO - 'sessionrestore', 07:39:06 INFO - 'sessionrestore_no_auto_restore', 07:39:06 INFO - 'tabpaint']}, 07:39:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:39:06 INFO - 'tests': ['a11yr', 07:39:06 INFO - 'ts_paint', 07:39:06 INFO - 'tpaint', 07:39:06 INFO - 'sessionrestore', 07:39:06 INFO - 'sessionrestore_no_auto_restore', 07:39:06 INFO - 'tabpaint']}, 07:39:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:39:06 INFO - 'tests': ['a11yr', 07:39:06 INFO - 'ts_paint', 07:39:06 INFO - 'tpaint', 07:39:06 INFO - 'sessionrestore', 07:39:06 INFO - 'sessionrestore_no_auto_restore', 07:39:06 INFO - 'tabpaint']}, 07:39:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:39:06 INFO - 'tests': ['tsvgx', 07:39:06 INFO - 'tsvgr_opacity', 07:39:06 INFO - 'tart', 07:39:06 INFO - 'tscrollx', 07:39:06 INFO - 'cart', 07:39:06 INFO - 'tsvg_static']}, 07:39:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:39:06 INFO - 'tsvgr_opacity', 07:39:06 INFO - 'tart', 07:39:06 INFO - 'tscrollx', 07:39:06 INFO - 'cart', 07:39:06 INFO - 'tsvg_static']}, 07:39:06 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:39:06 INFO - 'talos_options': ['--disable-e10s'], 07:39:06 INFO - 'tests': ['tp5o']}, 07:39:06 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:39:06 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:39:06 INFO - 'talos_options': ['--disable-e10s', 07:39:06 INFO - '--xperf_path', 07:39:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:39:06 INFO - 'tests': ['tp5n']}, 07:39:06 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:39:06 INFO - 'talos_options': ['--xperf_path', 07:39:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:39:06 INFO - 'tests': ['tp5n']}}, 07:39:06 INFO - 'talos.zip': {'path': '', 07:39:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:39:06 INFO - Running post-action listener: _resource_record_post_action 07:39:06 INFO - [mozharness: 2017-01-04 15:39:06.641588Z] Finished populate-webroot step (success) 07:39:06 INFO - [mozharness: 2017-01-04 15:39:06.641678Z] Running create-virtualenv step. 07:39:06 INFO - Running pre-action listener: _resource_record_pre_action 07:39:06 INFO - Running main action method: create_virtualenv 07:39:06 INFO - Creating virtualenv /builds/slave/test/build/venv 07:39:06 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 07:39:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:39:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:39:06 INFO - Using real prefix '/usr' 07:39:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:39:07 INFO - Installing distribute.............................................................................................................................................................................................done. 07:39:09 INFO - Installing pip.................done. 07:39:09 INFO - Return code: 0 07:39:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:39:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:39:09 INFO - Reading from file tmpfile_stdout 07:39:09 INFO - Output received: 07:39:09 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) 07:39:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:39:09 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')]} 07:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:09 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')]} 07:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:09 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 0x16a21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a14480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a11820>, '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 0x1a12520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a129b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745', '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 07:39:09 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 07:39:09 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 07:39:09 INFO - Using env: {'DISPLAY': ':0', 07:39:09 INFO - 'HOME': '/home/cltbld', 07:39:09 INFO - 'LANG': 'en_US.UTF-8', 07:39:09 INFO - 'LANGUAGE': 'en_US:en', 07:39:09 INFO - 'LOGNAME': 'cltbld', 07:39:09 INFO - 'MAIL': '/var/mail/cltbld', 07:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:09 INFO - 'MOZ_NO_REMOTE': '1', 07:39:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:39:09 INFO - 'NO_EM_RESTART': '1', 07:39:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:09 INFO - 'PWD': '/builds/slave/test', 07:39:09 INFO - 'SHELL': '/bin/bash', 07:39:09 INFO - 'SHLVL': '1', 07:39:09 INFO - 'TERM': 'linux', 07:39:09 INFO - 'TMOUT': '86400', 07:39:09 INFO - 'USER': 'cltbld', 07:39:09 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745', 07:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:09 INFO - '_': '/tools/buildbot/bin/python'} 07:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:39:09 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 07:39:09 INFO - Cleaning up... 07:39:09 INFO - Return code: 0 07:39:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:39:09 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')]} 07:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:39:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:09 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')]} 07:39:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:39:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:09 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 0x16a21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a14480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a11820>, '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 0x1a12520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a129b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745', '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 07:39:09 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 07:39:09 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 07:39:09 INFO - Using env: {'DISPLAY': ':0', 07:39:09 INFO - 'HOME': '/home/cltbld', 07:39:09 INFO - 'LANG': 'en_US.UTF-8', 07:39:09 INFO - 'LANGUAGE': 'en_US:en', 07:39:09 INFO - 'LOGNAME': 'cltbld', 07:39:09 INFO - 'MAIL': '/var/mail/cltbld', 07:39:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:09 INFO - 'MOZ_NO_REMOTE': '1', 07:39:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:39:09 INFO - 'NO_EM_RESTART': '1', 07:39:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:39:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:09 INFO - 'PWD': '/builds/slave/test', 07:39:09 INFO - 'SHELL': '/bin/bash', 07:39:09 INFO - 'SHLVL': '1', 07:39:09 INFO - 'TERM': 'linux', 07:39:09 INFO - 'TMOUT': '86400', 07:39:09 INFO - 'USER': 'cltbld', 07:39:09 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745', 07:39:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:09 INFO - '_': '/tools/buildbot/bin/python'} 07:39:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:39:09 INFO - Downloading/unpacking psutil>=3.1.1 07:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:39:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:39:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:39:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:39:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:39:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:39:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:39:11 INFO - Installing collected packages: psutil 07:39:11 INFO - Running setup.py install for psutil 07:39:12 INFO - building 'psutil._psutil_linux' extension 07:39:12 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 07:39:12 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 07:39:12 INFO - building 'psutil._psutil_posix' extension 07:39:12 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 07:39:12 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 07:39:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:39:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:39:12 INFO - Successfully installed psutil 07:39:12 INFO - Cleaning up... 07:39:12 INFO - Return code: 0 07:39:12 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:39: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')]} 07:39:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:39:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39: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')]} 07:39:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:39:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a14480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a11820>, '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 0x1a12520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a129b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745', '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 07:39:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:39:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:39:12 INFO - Using env: {'DISPLAY': ':0', 07:39:12 INFO - 'HOME': '/home/cltbld', 07:39:12 INFO - 'LANG': 'en_US.UTF-8', 07:39:12 INFO - 'LANGUAGE': 'en_US:en', 07:39:12 INFO - 'LOGNAME': 'cltbld', 07:39:12 INFO - 'MAIL': '/var/mail/cltbld', 07:39:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:12 INFO - 'MOZ_NO_REMOTE': '1', 07:39:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:39:12 INFO - 'NO_EM_RESTART': '1', 07:39:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:39:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:12 INFO - 'PWD': '/builds/slave/test', 07:39:12 INFO - 'SHELL': '/bin/bash', 07:39:12 INFO - 'SHLVL': '1', 07:39:12 INFO - 'TERM': 'linux', 07:39:12 INFO - 'TMOUT': '86400', 07:39:12 INFO - 'USER': 'cltbld', 07:39:12 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745', 07:39:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:12 INFO - '_': '/tools/buildbot/bin/python'} 07:39:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:39:12 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:39:12 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 07:39:12 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 07:39:12 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 07:39:12 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 07:39:12 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 07:39:12 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 07:39:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:39:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:39:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:39:14 INFO - Installing collected packages: mozsystemmonitor 07:39:14 INFO - Running setup.py install for mozsystemmonitor 07:39:14 INFO - Successfully installed mozsystemmonitor 07:39:14 INFO - Cleaning up... 07:39:14 INFO - Return code: 0 07:39:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:39:14 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')]} 07:39:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:39:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:14 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')]} 07:39:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:39:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:14 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 0x16a21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a14480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a11820>, '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 0x1a12520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a129b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745', '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 07:39:14 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 07:39:14 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 07:39:14 INFO - Using env: {'DISPLAY': ':0', 07:39:14 INFO - 'HOME': '/home/cltbld', 07:39:14 INFO - 'LANG': 'en_US.UTF-8', 07:39:14 INFO - 'LANGUAGE': 'en_US:en', 07:39:14 INFO - 'LOGNAME': 'cltbld', 07:39:14 INFO - 'MAIL': '/var/mail/cltbld', 07:39:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:14 INFO - 'MOZ_NO_REMOTE': '1', 07:39:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:39:14 INFO - 'NO_EM_RESTART': '1', 07:39:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:39:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:14 INFO - 'PWD': '/builds/slave/test', 07:39:14 INFO - 'SHELL': '/bin/bash', 07:39:14 INFO - 'SHLVL': '1', 07:39:14 INFO - 'TERM': 'linux', 07:39:14 INFO - 'TMOUT': '86400', 07:39:14 INFO - 'USER': 'cltbld', 07:39:14 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745', 07:39:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:14 INFO - '_': '/tools/buildbot/bin/python'} 07:39:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:39:15 INFO - Downloading/unpacking jsonschema==2.5.1 07:39:15 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 07:39:15 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 07:39:15 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 07:39:15 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 07:39:15 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 07:39:15 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 07:39:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:39:17 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:39:17 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 07:39:17 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 07:39:17 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 07:39:17 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 07:39:17 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 07:39:17 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 07:39:17 INFO - Downloading functools32-3.2.3-2.tar.gz 07:39:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:39:17 INFO - warning: no files found matching '*.txt' 07:39:17 INFO - no previously-included directories found matching 'build' 07:39:17 INFO - no previously-included directories found matching 'dist' 07:39:17 INFO - no previously-included directories found matching '.git*' 07:39:17 INFO - Installing collected packages: jsonschema, functools32 07:39:17 INFO - Running setup.py install for functools32 07:39:17 INFO - warning: no files found matching '*.txt' 07:39:17 INFO - no previously-included directories found matching 'build' 07:39:17 INFO - no previously-included directories found matching 'dist' 07:39:17 INFO - no previously-included directories found matching '.git*' 07:39:17 INFO - Successfully installed jsonschema functools32 07:39:17 INFO - Cleaning up... 07:39:17 INFO - Return code: 0 07:39:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:39:17 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')]} 07:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:39:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:17 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')]} 07:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:39:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:17 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 0x16a21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a14480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a11820>, '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 0x1a12520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a129b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745', '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 07:39:17 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 07:39:17 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 07:39:17 INFO - Using env: {'DISPLAY': ':0', 07:39:17 INFO - 'HOME': '/home/cltbld', 07:39:17 INFO - 'LANG': 'en_US.UTF-8', 07:39:17 INFO - 'LANGUAGE': 'en_US:en', 07:39:17 INFO - 'LOGNAME': 'cltbld', 07:39:17 INFO - 'MAIL': '/var/mail/cltbld', 07:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:17 INFO - 'MOZ_NO_REMOTE': '1', 07:39:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:39:17 INFO - 'NO_EM_RESTART': '1', 07:39:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:17 INFO - 'PWD': '/builds/slave/test', 07:39:17 INFO - 'SHELL': '/bin/bash', 07:39:17 INFO - 'SHLVL': '1', 07:39:17 INFO - 'TERM': 'linux', 07:39:17 INFO - 'TMOUT': '86400', 07:39:17 INFO - 'USER': 'cltbld', 07:39:17 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745', 07:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:17 INFO - '_': '/tools/buildbot/bin/python'} 07:39:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:39:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:39:17 INFO - Cleaning up... 07:39:17 INFO - Return code: 0 07:39:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:39:17 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')]} 07:39:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:39:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:17 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')]} 07:39:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:39:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:17 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 0x16a21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a14480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a11820>, '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 0x1a12520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a129b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745', '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 07:39:17 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 07:39:17 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 07:39:17 INFO - Using env: {'DISPLAY': ':0', 07:39:17 INFO - 'HOME': '/home/cltbld', 07:39:17 INFO - 'LANG': 'en_US.UTF-8', 07:39:17 INFO - 'LANGUAGE': 'en_US:en', 07:39:17 INFO - 'LOGNAME': 'cltbld', 07:39:17 INFO - 'MAIL': '/var/mail/cltbld', 07:39:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:17 INFO - 'MOZ_NO_REMOTE': '1', 07:39:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:39:17 INFO - 'NO_EM_RESTART': '1', 07:39:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:39:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:17 INFO - 'PWD': '/builds/slave/test', 07:39:17 INFO - 'SHELL': '/bin/bash', 07:39:17 INFO - 'SHLVL': '1', 07:39:17 INFO - 'TERM': 'linux', 07:39:17 INFO - 'TMOUT': '86400', 07:39:17 INFO - 'USER': 'cltbld', 07:39:17 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745', 07:39:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:17 INFO - '_': '/tools/buildbot/bin/python'} 07:39:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:39:18 INFO - Downloading/unpacking blobuploader==1.2.4 07:39:18 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 07:39:18 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 07:39:18 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 07:39:18 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 07:39:18 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 07:39:18 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 07:39:20 INFO - Downloading blobuploader-1.2.4.tar.gz 07:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:39:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:39:20 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 07:39:20 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 07:39:20 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 07:39:20 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 07:39:20 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 07:39:20 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 07:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:39:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:39:20 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 07:39:20 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 07:39:20 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 07:39:20 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 07:39:20 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 07:39:20 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 07:39:20 INFO - Downloading docopt-0.6.1.tar.gz 07:39:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:39:20 INFO - Installing collected packages: blobuploader, requests, docopt 07:39:20 INFO - Running setup.py install for blobuploader 07:39:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:39:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:39:21 INFO - Running setup.py install for requests 07:39:21 INFO - Running setup.py install for docopt 07:39:21 INFO - Successfully installed blobuploader requests docopt 07:39:21 INFO - Cleaning up... 07:39:21 INFO - Return code: 0 07:39:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:39: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')]} 07:39:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:39:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39: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')]} 07:39:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:39:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:21 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 0x16a21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a14480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a11820>, '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 0x1a12520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a129b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745', '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 07:39:21 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 07:39:21 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 07:39:21 INFO - Using env: {'DISPLAY': ':0', 07:39:21 INFO - 'HOME': '/home/cltbld', 07:39:21 INFO - 'LANG': 'en_US.UTF-8', 07:39:21 INFO - 'LANGUAGE': 'en_US:en', 07:39:21 INFO - 'LOGNAME': 'cltbld', 07:39:21 INFO - 'MAIL': '/var/mail/cltbld', 07:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:21 INFO - 'MOZ_NO_REMOTE': '1', 07:39:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:39:21 INFO - 'NO_EM_RESTART': '1', 07:39:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:21 INFO - 'PWD': '/builds/slave/test', 07:39:21 INFO - 'SHELL': '/bin/bash', 07:39:21 INFO - 'SHLVL': '1', 07:39:21 INFO - 'TERM': 'linux', 07:39:21 INFO - 'TMOUT': '86400', 07:39:21 INFO - 'USER': 'cltbld', 07:39:21 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745', 07:39:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:21 INFO - '_': '/tools/buildbot/bin/python'} 07:39:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:39:21 INFO - Running setup.py (path:/tmp/pip-Sa_OIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:39:21 INFO - Running setup.py (path:/tmp/pip-vrQRNH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:39:21 INFO - Running setup.py (path:/tmp/pip-wPp3T_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:39:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:39:21 INFO - Running setup.py (path:/tmp/pip-YHxYGH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:39:22 INFO - Running setup.py (path:/tmp/pip-buoT1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:39:22 INFO - Running setup.py (path:/tmp/pip-3ypqnp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:39:22 INFO - Running setup.py (path:/tmp/pip-aKGpyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:39:22 INFO - Running setup.py (path:/tmp/pip-LnYVUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:39:22 INFO - Running setup.py (path:/tmp/pip-moPCqS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:39:22 INFO - Running setup.py (path:/tmp/pip-qUKITf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:39:22 INFO - Running setup.py (path:/tmp/pip-c_cX_V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:39:22 INFO - Running setup.py (path:/tmp/pip-ANOMK0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:39:22 INFO - Running setup.py (path:/tmp/pip-ZGJg5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:39:22 INFO - Running setup.py (path:/tmp/pip-EbjKtw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:39:22 INFO - Running setup.py (path:/tmp/pip-Y52k9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:39:22 INFO - Running setup.py (path:/tmp/pip-2dOVPF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:39:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:39:22 INFO - Running setup.py (path:/tmp/pip-Eom50_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:39:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:39:23 INFO - Running setup.py install for manifestparser 07:39:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:39:23 INFO - Running setup.py install for mozcrash 07:39:23 INFO - Running setup.py install for mozdebug 07:39:23 INFO - Running setup.py install for mozdevice 07:39:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:39:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:39:23 INFO - Running setup.py install for mozfile 07:39:23 INFO - Running setup.py install for mozhttpd 07:39:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:39:23 INFO - Running setup.py install for mozinfo 07:39:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:39:23 INFO - Running setup.py install for mozInstall 07:39:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:39:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:39:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:39:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:39:23 INFO - Running setup.py install for mozleak 07:39:23 INFO - Running setup.py install for mozlog 07:39:24 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:39:24 INFO - Running setup.py install for moznetwork 07:39:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:39:24 INFO - Running setup.py install for mozprocess 07:39:24 INFO - Running setup.py install for mozprofile 07:39:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:39:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:39:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:39:24 INFO - Running setup.py install for mozrunner 07:39:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:39:24 INFO - Running setup.py install for mozscreenshot 07:39:24 INFO - Running setup.py install for moztest 07:39:24 INFO - Running setup.py install for mozversion 07:39:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:39:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:39:24 INFO - Cleaning up... 07:39:24 INFO - Return code: 0 07:39:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:39: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')]} 07:39:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:39:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39: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')]} 07:39:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:39:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:24 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 0x16a21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a14480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a11820>, '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 0x1a12520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a129b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745', '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 07:39:24 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 07:39:24 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 07:39:24 INFO - Using env: {'DISPLAY': ':0', 07:39:24 INFO - 'HOME': '/home/cltbld', 07:39:24 INFO - 'LANG': 'en_US.UTF-8', 07:39:24 INFO - 'LANGUAGE': 'en_US:en', 07:39:24 INFO - 'LOGNAME': 'cltbld', 07:39:24 INFO - 'MAIL': '/var/mail/cltbld', 07:39:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:24 INFO - 'MOZ_NO_REMOTE': '1', 07:39:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:39:24 INFO - 'NO_EM_RESTART': '1', 07:39:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:39:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:24 INFO - 'PWD': '/builds/slave/test', 07:39:24 INFO - 'SHELL': '/bin/bash', 07:39:24 INFO - 'SHLVL': '1', 07:39:24 INFO - 'TERM': 'linux', 07:39:24 INFO - 'TMOUT': '86400', 07:39:24 INFO - 'USER': 'cltbld', 07:39:24 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745', 07:39:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:24 INFO - '_': '/tools/buildbot/bin/python'} 07:39:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:39:25 INFO - Running setup.py (path:/tmp/pip-jHm0dP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:39:25 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)) 07:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:39:25 INFO - Running setup.py (path:/tmp/pip-dmlnHA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:39:25 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)) 07:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:39:25 INFO - Running setup.py (path:/tmp/pip-XtOE0A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:39:25 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)) 07:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:39:25 INFO - Running setup.py (path:/tmp/pip-HSIYZP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:39:25 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)) 07:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:39:25 INFO - Running setup.py (path:/tmp/pip-mWByWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:39:25 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)) 07:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:39:25 INFO - Running setup.py (path:/tmp/pip-S0vwyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:39:25 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)) 07:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:39:25 INFO - Running setup.py (path:/tmp/pip-z7v9iE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:39:25 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)) 07:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:39:25 INFO - Running setup.py (path:/tmp/pip-ArxJ5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:39:25 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)) 07:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:39:25 INFO - Running setup.py (path:/tmp/pip-OAxW93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:39:25 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)) 07:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:39:25 INFO - Running setup.py (path:/tmp/pip-uy2Vpu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:39:25 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)) 07:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:39:25 INFO - Running setup.py (path:/tmp/pip-K4n5ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:39:25 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)) 07:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:39:25 INFO - Running setup.py (path:/tmp/pip-Ryh8M_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:39:25 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)) 07:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:39:25 INFO - Running setup.py (path:/tmp/pip-Cci9Gi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:39:25 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)) 07:39:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:39:25 INFO - Running setup.py (path:/tmp/pip-vmk6ze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:39:26 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)) 07:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:39:26 INFO - Running setup.py (path:/tmp/pip-IJHDnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:39:26 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)) 07:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:39:26 INFO - Running setup.py (path:/tmp/pip-0NbyFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:39:26 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)) 07:39:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:39:26 INFO - Running setup.py (path:/tmp/pip-Eqy0Mi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:39:26 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)) 07:39:26 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)) 07:39:26 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)) 07:39:26 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)) 07:39:26 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)) 07:39:26 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)) 07:39:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:39: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 07:39: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 07:39: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 07:39: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 07:39: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 07:39: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 07:39:28 INFO - Downloading blessings-1.6.tar.gz 07:39:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:39:28 INFO - Installing collected packages: blessings 07:39:28 INFO - Running setup.py install for blessings 07:39:28 INFO - Successfully installed blessings 07:39:28 INFO - Cleaning up... 07:39:28 INFO - Return code: 0 07:39:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:39:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:39:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:39:28 INFO - Reading from file tmpfile_stdout 07:39:28 INFO - Current package versions: 07:39:28 INFO - argparse == 1.2.1 07:39:28 INFO - blessings == 1.6 07:39:28 INFO - blobuploader == 1.2.4 07:39:28 INFO - docopt == 0.6.1 07:39:28 INFO - functools32 == 3.2.3-2 07:39:28 INFO - jsonschema == 2.5.1 07:39:28 INFO - manifestparser == 1.1 07:39:28 INFO - mozInstall == 1.12 07:39:28 INFO - mozcrash == 1.0 07:39:28 INFO - mozdebug == 0.1 07:39:28 INFO - mozdevice == 0.49 07:39:28 INFO - mozfile == 1.2 07:39:28 INFO - mozhttpd == 0.7 07:39:28 INFO - mozinfo == 0.9 07:39:28 INFO - mozleak == 0.1 07:39:28 INFO - mozlog == 3.4 07:39:28 INFO - moznetwork == 0.27 07:39:28 INFO - mozprocess == 0.23 07:39:28 INFO - mozprofile == 0.28 07:39:28 INFO - mozrunner == 6.13 07:39:28 INFO - mozscreenshot == 0.1 07:39:28 INFO - mozsystemmonitor == 0.3 07:39:28 INFO - moztest == 0.8 07:39:28 INFO - mozversion == 1.4 07:39:28 INFO - psutil == 3.1.1 07:39:28 INFO - requests == 1.2.3 07:39:28 INFO - wsgiref == 0.1.2 07:39:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:39: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')]} 07:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39: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')]} 07:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:28 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 0x16a21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a14480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a11820>, '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 0x1a12520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a129b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745', '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 07:39:28 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 07:39:28 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 07:39:28 INFO - Using env: {'DISPLAY': ':0', 07:39:28 INFO - 'HOME': '/home/cltbld', 07:39:28 INFO - 'LANG': 'en_US.UTF-8', 07:39:28 INFO - 'LANGUAGE': 'en_US:en', 07:39:28 INFO - 'LOGNAME': 'cltbld', 07:39:28 INFO - 'MAIL': '/var/mail/cltbld', 07:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:28 INFO - 'MOZ_NO_REMOTE': '1', 07:39:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:39:28 INFO - 'NO_EM_RESTART': '1', 07:39:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:28 INFO - 'PWD': '/builds/slave/test', 07:39:28 INFO - 'SHELL': '/bin/bash', 07:39:28 INFO - 'SHLVL': '1', 07:39:28 INFO - 'TERM': 'linux', 07:39:28 INFO - 'TMOUT': '86400', 07:39:28 INFO - 'USER': 'cltbld', 07:39:28 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745', 07:39:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:28 INFO - '_': '/tools/buildbot/bin/python'} 07:39:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:39:28 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)) 07:39:28 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)) 07:39:28 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)) 07:39:28 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)) 07:39:28 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)) 07:39:28 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)) 07:39:28 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)) 07:39:28 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)) 07:39:28 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)) 07:39:28 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)) 07:39:28 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)) 07:39:28 INFO - Cleaning up... 07:39:28 INFO - Return code: 0 07:39:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:39: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')]} 07:39:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:39:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39: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')]} 07:39:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:39:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:39:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x16a21f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17b3a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a14480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a11820>, '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 0x1a12520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a129b0>, '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': 'ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745', '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 07:39:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:39:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:39:28 INFO - Using env: {'DISPLAY': ':0', 07:39:28 INFO - 'HOME': '/home/cltbld', 07:39:28 INFO - 'LANG': 'en_US.UTF-8', 07:39:28 INFO - 'LANGUAGE': 'en_US:en', 07:39:28 INFO - 'LOGNAME': 'cltbld', 07:39:28 INFO - 'MAIL': '/var/mail/cltbld', 07:39:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:28 INFO - 'MOZ_NO_REMOTE': '1', 07:39:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:39:28 INFO - 'NO_EM_RESTART': '1', 07:39:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:39:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:28 INFO - 'PWD': '/builds/slave/test', 07:39:28 INFO - 'SHELL': '/bin/bash', 07:39:28 INFO - 'SHLVL': '1', 07:39:29 INFO - 'TERM': 'linux', 07:39:29 INFO - 'TMOUT': '86400', 07:39:29 INFO - 'USER': 'cltbld', 07:39:29 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745', 07:39:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:29 INFO - '_': '/tools/buildbot/bin/python'} 07:39:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:39:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:39:29 INFO - Cleaning up... 07:39:29 INFO - Return code: 0 07:39:29 INFO - Running post-action listener: _resource_record_post_action 07:39:29 INFO - Running post-action listener: _start_resource_monitoring 07:39:29 INFO - Starting resource monitoring. 07:39:29 INFO - [mozharness: 2017-01-04 15:39:29.246269Z] Finished create-virtualenv step (success) 07:39:29 INFO - [mozharness: 2017-01-04 15:39:29.246772Z] Running install step. 07:39:29 INFO - Running pre-action listener: _resource_record_pre_action 07:39:29 INFO - Running main action method: install 07:39:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:39:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:39:29 INFO - Reading from file tmpfile_stdout 07:39:29 INFO - Detecting whether we're running mozinstall >=1.0... 07:39:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:39:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:39:29 INFO - Reading from file tmpfile_stdout 07:39:29 INFO - Output received: 07:39:29 INFO - Usage: mozinstall [options] installer 07:39:29 INFO - Options: 07:39:29 INFO - -h, --help show this help message and exit 07:39:29 INFO - -d DEST, --destination=DEST 07:39:29 INFO - Directory to install application into. [default: 07:39:29 INFO - "/builds/slave/test"] 07:39:29 INFO - --app=APP Application being installed. [default: firefox] 07:39:29 INFO - mkdir: /builds/slave/test/build/application 07:39:29 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'] 07:39:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:39:45 INFO - Reading from file tmpfile_stdout 07:39:45 INFO - Output received: 07:39:45 INFO - /builds/slave/test/build/application/firefox/firefox 07:39:45 INFO - Running post-action listener: _resource_record_post_action 07:39:45 INFO - [mozharness: 2017-01-04 15:39:45.658530Z] Finished install step (success) 07:39:45 INFO - [mozharness: 2017-01-04 15:39:45.658805Z] Running run-tests step. 07:39:45 INFO - Running pre-action listener: _resource_record_pre_action 07:39:45 INFO - Running main action method: run_tests 07:39:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:39:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:39:45 INFO - Python 2.7.3 07:39:45 INFO - Return code: 0 07:39:45 INFO - grabbing minidump binary from tooltool 07:39:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:39:45 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 0x1a11820>, '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 0x1a12520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a129b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:39:45 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 07:39:45 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 07:39:45 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 07:39:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:39:45 INFO - Return code: 0 07:39:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:39:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:39:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:39:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:39:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:39:45 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/MLNBNqopQE2dS_AxiBPXDA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 07:39:45 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/MLNBNqopQE2dS_AxiBPXDA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 07:39:45 INFO - Using env: {'DISPLAY': ':0', 07:39:45 INFO - 'HOME': '/home/cltbld', 07:39:45 INFO - 'LANG': 'en_US.UTF-8', 07:39:45 INFO - 'LANGUAGE': 'en_US:en', 07:39:45 INFO - 'LOGNAME': 'cltbld', 07:39:45 INFO - 'MAIL': '/var/mail/cltbld', 07:39:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:39:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:39:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:39:45 INFO - 'MOZ_NO_REMOTE': '1', 07:39:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:39:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:39:45 INFO - 'NO_EM_RESTART': '1', 07:39:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:39:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:39:45 INFO - 'PWD': '/builds/slave/test', 07:39:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:39:45 INFO - 'SHELL': '/bin/bash', 07:39:45 INFO - 'SHLVL': '1', 07:39:45 INFO - 'TERM': 'linux', 07:39:45 INFO - 'TMOUT': '86400', 07:39:45 INFO - 'USER': 'cltbld', 07:39:45 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745', 07:39:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:39:45 INFO - '_': '/tools/buildbot/bin/python'} 07:39:45 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/MLNBNqopQE2dS_AxiBPXDA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 07:39:45 INFO - mozversion application_buildid: 20170104151038 07:39:45 INFO - mozversion application_changeset: a2741dd43eeae54f4dd7423bd832a761481c56ce 07:39:45 INFO - mozversion application_display_name: Nightly 07:39:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:39:45 INFO - mozversion application_name: Firefox 07:39:45 INFO - mozversion application_remotingname: firefox 07:39:45 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:39:45 INFO - mozversion application_vendor: Mozilla 07:39:45 INFO - mozversion application_version: 53.0a1 07:39:45 INFO - mozversion platform_buildid: 20170104151038 07:39:45 INFO - mozversion platform_changeset: a2741dd43eeae54f4dd7423bd832a761481c56ce 07:39:45 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:39:45 INFO - mozversion platform_version: 53.0a1 07:39:45 INFO - using testdate: 1483544385 07:39:45 INFO - actual date: 1483544385 07:39:45 INFO - starting webserver on 'localhost:60888' 07:39:45 INFO - SUITE-START | Running 2 tests 07:39:45 INFO - TEST-START | dromaeo_css 07:39:45 INFO - operating with platform_type : linux_ 07:39:45 INFO - Initialising browser for dromaeo_css test... 07:39:45 INFO - TEST-INFO | started process 1042 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu_eQoX/profile http://localhost:60888/getInfo.html) 07:39:46 INFO - PROCESS | 1042 | 1483544386464 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 07:39:50 INFO - PROCESS | 1042 | __metrics Screen width/height:1600/1200 07:39:50 INFO - PROCESS | 1042 | colorDepth:24 07:39:50 INFO - PROCESS | 1042 | Browser inner width/height: 1024/697 07:39:50 INFO - PROCESS | 1042 | __metrics 07:39:50 ERROR - PROCESS | 1042 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 07:39:51 INFO - TEST-INFO | 1042: exit 0 07:39:51 INFO - Browser initialized. 07:39:51 INFO - Running cycle 1/1 for dromaeo_css test... 07:39:51 INFO - TEST-INFO | started process 1182 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpu_eQoX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:40:03 INFO - PROCESS | 1182 | RSS: Main: 158310400 07:40:03 INFO - PROCESS | 1182 | 07:40:53 INFO - PROCESS | 1182 | 1483544453565 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] 07:43:07 INFO - PROCESS | 1182 | Cycle 1(1): loaded http://localhost:60888/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60888/tests/dromaeo/cssquery-ext.html) 07:43:08 INFO - PROCESS | 1182 | RSS: Main: 165543936 07:43:08 INFO - PROCESS | 1182 | 07:44:52 INFO - PROCESS | 1182 | ************************* 07:44:52 INFO - PROCESS | 1182 | A coding exception was thrown and uncaught in a Task. 07:44:52 INFO - PROCESS | 1182 | 07:44:52 INFO - PROCESS | 1182 | Full message: ReferenceError: fetch is not defined 07:44:52 INFO - PROCESS | 1182 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 07:44:52 INFO - PROCESS | 1182 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 07:44:52 INFO - PROCESS | 1182 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 07:44:52 INFO - PROCESS | 1182 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 07:44:52 INFO - PROCESS | 1182 | TaskImpl@resource://gre/modules/Task.jsm:277:3 07:44:52 INFO - PROCESS | 1182 | asyncFunction@resource://gre/modules/Task.jsm:252:14 07:44:52 INFO - PROCESS | 1182 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 07:44:52 INFO - PROCESS | 1182 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 07:44:52 INFO - PROCESS | 1182 | TaskImpl@resource://gre/modules/Task.jsm:277:3 07:44:52 INFO - PROCESS | 1182 | asyncFunction@resource://gre/modules/Task.jsm:252:14 07:44:52 INFO - PROCESS | 1182 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 07:44:52 INFO - PROCESS | 1182 | 07:44:52 INFO - PROCESS | 1182 | ************************* 07:46:11 INFO - PROCESS | 1182 | Cycle 1(1): loaded http://localhost:60888/tests/dromaeo/cssquery-ext.html (next: http://localhost:60888/tests/dromaeo/cssquery-jquery.html) 07:46:12 INFO - PROCESS | 1182 | RSS: Main: 162013184 07:46:12 INFO - PROCESS | 1182 | 07:49:14 INFO - PROCESS | 1182 | Cycle 1(1): loaded http://localhost:60888/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60888/tests/dromaeo/cssquery-mootools.html) 07:49:14 INFO - PROCESS | 1182 | RSS: Main: 167731200 07:49:14 INFO - PROCESS | 1182 | 07:52:16 INFO - PROCESS | 1182 | Cycle 1(1): loaded http://localhost:60888/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60888/tests/dromaeo/cssquery-prototype.html) 07:52:17 INFO - PROCESS | 1182 | RSS: Main: 162770944 07:52:17 INFO - PROCESS | 1182 | 07:55:20 INFO - PROCESS | 1182 | Cycle 1(1): loaded http://localhost:60888/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60888/tests/dromaeo/cssquery-yui.html) 07:55:21 INFO - PROCESS | 1182 | RSS: Main: 165814272 07:55:21 INFO - PROCESS | 1182 | 07:58:24 INFO - PROCESS | 1182 | Cycle 1(1): loaded http://localhost:60888/tests/dromaeo/cssquery-yui.html (next: http://localhost:60888/tests/dromaeo/cssquery-dojo.html) 07:58:24 INFO - PROCESS | 1182 | RSS: Main: 166555648 07:58:24 INFO - PROCESS | 1182 | 07:58:24 INFO - PROCESS | 1182 | __start_tp_report 07:58:24 INFO - PROCESS | 1182 | _x_x_mozilla_page_load 07:58:24 INFO - PROCESS | 1182 | _x_x_mozilla_page_load_details 07:58:24 INFO - PROCESS | 1182 | |i|pagename|runs| 07:58:24 INFO - PROCESS | 1182 | |0;dojo.html;2517.295157355941;2547.057588692184;2583.767460928517;2594.377349436136;2629.2375211188746;4735.360726301957;4782.402199725035;4792.353032340633;4803.783829727662;4808.447028591713;4741.122892264933;4758.666893317469;4819.1325561398935;4820.879478013051;4876.756162191885;4347.586979236975;4403;4408.713433626804;4438.423005009345;4500.572445617661;4020.4170395292663;4521.547845215485;4527.773611319437;4537.31940208968;4542.09158168366;4377.737335759833;4395.7362558246605;4409.11817636474;4433.667474939376;4496;4348.043430445297;4389.407429996942;4390.846320378803;4414.713043652152;4468.285074388083;4372.846950356722;4373.956260437419;4393;4394.340848872663;4401.867943961686;4700.882477938045;4736.2895565665085;4757.452892917289;4782.33047373368;4788.592969597588;4939.629527785431;4942.283368911488;4997.6501644884875;5021.472745361758;5026.522480364396;5033.094043072246;5047.520485553903;5048.7980480780725;5065.11360511909;5067.746612669389;4744.406949131324;4758;4767.95232047682;4775.641826863;4798.760061996956;5080.7205603692155;5102.974485127551;5106.591472682177;5171.3535808024;5180.948190518122;4911.8280860169725;4942.5304596063315;4947.406311242602;4970.304157417964;4990.800367985313;4998.350214472095;5046.243063540498;5047.116754567936;5054.570361519312;5059.519345662156;5067.822626208139;5090.211017292326;5115.38615366151;5164.0962831505085;5172;5041.344625198774;5094.490550944876;5104.2343648453025;5111.642185047085;5143.408508021551;4163.39630753539;4185.644220241253;4292.506361768436;4293.527711951683;4314.331278651814;3675.8162091895833;3680.0799800049986;3702.5371828521434;3735.1782607826235;3768.660820526166;4475.127350166751;4479.664025198123;4480.260756975128;4515.571020753023;4519.29950857611;5000.524950129732;5174.275601415805;5176.689398636094;5181.844544663666;5183.714895680699;4375.956240437618;4442.133783912106;4445.955540444619;4454.532274111237;4454.732716037048;4550.88622784433;4563.589276965089;4567.5432456754725;4577.267637178102;4580.633549316047;4809.78355973982;4810.134175848311;4815.036992601564;4815.892344760655;4828.348172996671;5087.694738315713;5093.853882876323;5098.898022039464;5116.846494605168;5125.948740512547;4801.783919723691;4815.253635686474;4817.710937343771;4820.68665536739;4820.903581928412;4900.26496025599;5012.924806127838;5129.410117836496;5157.8452646420665;5173.22401639742;5097.235414687826;5105.5149760772665;5124.12889808726;5154.5103215194495;5179.611529135254;4993.425756038102;5021.447640759587;5024.799008039638;5033.043721692867;5054.368203974504;4891.559759621651;4936.333594964633;4947.1589829729755;4963.726995015309;5000.949990500194;4853.878653033702;4864.781084851261;4883.145449546386;4895.388076490439;4925.876853078702;5044.319016932667;5047.722375269395;5049;5057.8482645519225;5059.3169922061525;4781.9043619128115;4810.350602668595;4824.324594556835;4875.098106850244;4969.527894850128 07:58:24 INFO - PROCESS | 1182 | |1;ext.html;522.7882707503461;538.9164679474683;540.8404520666403;541.8455740114066;545.68623041751;39122.413163802565;41904.790476047616;41925.16149677009;41985;45813.31280030794;41478.79260603693;42030.36954445678;42034.15931681372;42133.36799947995;42176.578234217726;7655.578943158138;7861.095973962982;7888.723894663688;9728.270379721549;10115.14021308186;9652.613895444209;9663.468509231989;9716.465594392306;9736.707898763014;9744.853827192563;9737.853932191023;9815.312928095;9820.607175713;9853.211743060574;9855.753606159868;9714.65998690046;9724.75688107796;9759.41443513388;9759.756006099833;9760.316777825556;9658.130768230892;9677.37097088687;9702.369345992487;9748.073932976356;9791.853122203172;34534;34743.13142171466;34794;34814.477782833026;34835.47746783775;3552.751307408457;3601.730573128596;3607.549056367954;3622.474741162543;3646.197836475971;26692.33269168267;26818.195454136407;27033;27147.457050858873;27373.589396159074;3147.35479226758;3149.8267595282477;3203.3913556424204;3287.0467564406295;3293.901182964515;241311.79344103343;241980;242893;243582;243595;46454.535454645695;46562.5343746565;46722.76638616785;46733.29900051502;46738;49322;49335.25997110046;49374.50625493699;49393.50606493889;49533.79895111034;11961.820572691417;12266.791977444145;12268.018558515298;12300.261984280973;12318.199317044364;8957.865632015524;9142.405743626643;9492.145706886413;9636.277279204087;9739;15894.125823079841;15925.761113583305;16015.359385624677;16047.518574442553;16128.919355403148;6404.083589723088;6560.803175904731;6593.967030164818;6653.935370340722;6773.593584384953;775.1241097559721;793.4208028139491;798.3892322373389;799.7440818938001;808.1393316118315;27315;28607.28481787972;28848.7115128846;28880.292671224594;29247.976320828668;959.1655259923772;961.9230461563199;973.5424350555228;992.2111921022804;1061.2518174686827;14850.183239921907;15447;15473.767893481607;15578.922105389627;15688.137152456724;351353;352248;352634;353015;355040;53051;53244;53774.7311263449;53864.461355385945;54094.729526352115;1203.5426537915537;1232.0328542094412;1239.4980033086615;1246.0343233993729;1249.3565813606;25888;27006.459870802082;27831.909258981825;28050.2987425316;28053;44397;44691.32963005623;44867.32699009452;44894.3265851006;44982.55017449784;240726;241749;242080;242611;242648;23227.651585225896;23911;24101.638475423235;25310.620340695274;26362.736372636027;35242.295154097286;35416.64583354133;37173.814130929175;37510.62489375071;38751.224975500896;32676.673233267364;32684.34631307313;32772.180695482806;33079.17302067467;33222.5016624746;31272.21819454532;31546.842265788524;31549.36901261916;32239.35521289514;32375.51436728404;30973.69026309708;31279;31518.842405787826;31678.36643267168;31979.84010079935;27463.626818658588;28074.2981425466;29442.411151777273;29558.704412956457;29685.40629187361;23085;23107.88446057759;23166.34101345899;23339.76660233444;23425.531489370456 07:58:24 INFO - PROCESS | 1182 | |2;jquery.html;358.2566175186488;361.62571738250915;363.9781613103214;370.5016752467933;384.17019238444965;16361.509154725363;16427;17718.379856705003;17782.288708451648;17790.64418711625;17553.473395798115;17858.821411785877;17940.770661280996;17962.281508739634;18051.819481805178;4871.220604703248;5137;5141.357330333708;5145.382554093495;5146.40816306124;4923.507649235084;5024.070546948826;5036.974815125919;5112.284280200774;5120.539151476366;5042.520960508764;5048.823291184809;5051.747412629372;5056.898862022757;5063.898722025576;4948;4979.601631869442;5028.346314979048;5036.294918711384;5049.72226527539;4489.551044895485;4504.054148628792;4531.297648864432;4540.27355623102;4542.0234649550175;21189.470263243387;21485.785142148536;21497.032633531373;21569.78430215709;21656.458588535254;2190.835687323457;2291.0721157931066;2320.1995311617466;2322.198841399714;2342.7657234276608;13035.413406396736;13718.039737218398;13968.790468142986;14298.64253393663;14380.712385752226;1712.7174016287297;1732.385003323827;1737.6177241006958;1759.366628013914;1761.462753860072;71827.28172718258;72347.27652723511;72628;74153.25846741571;74858.62570687111;9410.529473526296;9591.280653950982;9723.902760972442;9965.40207587547;10004.749881253027;13146.802797958038;13152.736945261233;13184.208947463183;13191.208527488381;13282.535111271252;6963.825904352431;7175.96412017947;7206.711731530785;7331.963340183265;7382.372498337594;6821.556598821061;6870.282220319014;7016.0528328676;7026.894596581055;7042;6171.59884607499;6271.843203919847;6284.905726414107;6436.3241859605005;6476.190476190476;1755.5260079778643;1766.143420441085;1768.6816373052975;1794.596215851423;1800.8199180081888;818.9631466583899;819.8073452738602;822.268181318627;829.4649950781712;834.8789425533264;14195.006349555639;14941.252937353089;15005.77491337609;15124.848751512563;15178.696426071638;815.8531464336357;820.5938060660012;825.5264353129635;829.618375547243;840.1598401598402;8333.374996875258;8884.511351875708;9199.63201471947;9352.158305752515;9413.275336064082;447817;449629;455242;456424;464425;71221;71301;72314.49169574764;73186.63406683039;73337;942.4167398770132;959.7744530035436;989.0159291504855;990.9306348555532;994.7363948553639;12998.350082495648;13370.331483425594;13374.665633358854;14068.859311406755;14112.647183820487;34664.30671386508;34683.4797478033;34959.475607866414;35382.33882578775;35457.46813797847;47772.761136194094;48964.510354895996;49627.50372496229;58286;58873.11690324734;7525.88711169322;7703.691852325845;7756.263155000266;7945.245201705829;7955.920440795518;8181.79545511367;11727.882721172678;12137.939310303393;12256.509739610672;12604.873951260737;9995.900040999497;10256.282060255711;10265.897341026493;10358.430286334324;10600.151987841109;10546.314489558154;10640.627578034731;10652.400861143213;10685.3054551457;10688.144948404264;10214.033054217722;10740.355578665305;10791.298565593212;10811.513481893491;10919.19674874478;7575.583342916192;7638.312551870358;7652.693892244248;7759.495632783851;7894.723684671009;6868.210155832143;7197.280271972971;7634.847303054019;9099.49952752605;10449.895501045195 07:58:24 INFO - PROCESS | 1182 | |3;mootools.html;1293.7994610835324;1315.9473621055151;1317.0780453682426;1321.1412581821814;1331.0866053801822;5973.940260597393;6214.440700336969;6613.14029176207;6881.759138430156;6978.8255293617685;6433.710483028263;6609.372109649587;6614.933850661492;6780.55926364786;6791.049253104569;1992.452075679189;2034.298167132337;2044.4479990402583;2044.672852343618;2054.6609809381434;1981.8018198180212;1997.5805080933021;2045.549979004624;2049.415916463808;2062.236972320236;2087.7390326209224;2099.84251181162;2106.7682554918947;2108.5361220531536;2115.555733296002;1986.503374156461;2000.679891217413;2002.6395248855201;2009.2867032203576;2010.507425680703;2059.423361458794;2068.803463670964;2074.087401543316;2082.6563617003176;2084.2809230815346;6927.168739751211;6988.790336289869;7007.789766307019;7025.648717564152;7044.894326585106;4057.857974970862;4208.284591619432;4211.031462763551;4215.367694845767;4225.34507151389;2622.5148347555764;2765.9170224893287;2838.815476993989;2847.957280640792;2847.985760071207;1081.9729506762314;1084.9945750271197;1103.42070413033;1129.074159189465;1130.5647325779553;8790.252828509585;8802.603882825224;8822.250108740765;8843.0714774949;8844.73465796027;3586;3615.096225943514;3640.927181456409;3651.6165802590876;3674.228412033503;7304.086989126359;7311.670974806147;7345.412367010626;7352.816179595446;7364.77905662831;4156.418101465797;4192.979035104805;4253.893652658709;4255.510616279167;4256.127493863751;3828.062124779447;3926.5484469285825;3973.5033120859894;3982.1239327348517;3990.660793832557;2964.7183517565795;2981.9701802981695;3050.084974507639;3053.435114503824;3068.800527965675;870.56906831119;884.2704768565959;892.3708785306344;919.5264438814016;924.8658944453017;806.8910697055823;808.9393295502861;812.5490352854105;815.3273549321833;826.8635675113659;4498.367888390437;4565.132624801277;4588.977055114769;4722.126406614787;4780.402449693788;875.8029443375317;904.5612877754284;917.7109210598641;930.0327659234321;930.6463543853428;3260.7717459778064;3318.502224666271;3387.5596172497417;3395.117269509896;3444.6383129771516;8002.639881205359;8100;8206.302464290482;8211.753647390588;8246.422750407533;8097.514149151069;8114.756557303291;8124.187581241828;8124.268815806606;8154.062282837431;6408.839779005469;6432.2602900667025;6489.545731798823;6582.341765823475;6603.108580341688;4703.905921881612;4731.361266229015;4779.1636463619425;4811.735354555393;4857.781399836945;7389.963050184715;7439.628018599156;7459.850802983801;7521.4734968551675;7524.924750752422;7191.173015103121;7377.4835761498325;7513.774586762406;7586.355159811478;7598.430117741081;5972.104184372379;6062.211912451353;6092.147099406176;6093.268807743099;6134.171886795404;6475.287718350884;6545.639989800607;6562.901556476561;6563.638999854863;6584.045313429621;5166.870828229325;5940.881182376242;5980.222571065908;6022.397760223943;6035.758569657164;5908.645481271137;5918.082697181943;6003.5797494174985;6068.817935461943;6108.205933228652;5369.1140961740875;5448.45515448452;5484.588655850907;5492.615516913777;5496.1755736639825;4091.5703851096396;4154.813033413564;4217.662586992972;4269.082147338338;4354.107407981292;4102.733322334038;4169.2703776839535;4194.0563373240775;4253.404523366793;4291.656667466657 07:58:24 INFO - PROCESS | 1182 | |4;prototype.html;317.90481790232644;320.8844815866289;323.17267794446207;324.29951305180816;328.76657573123083;4954.430240522341;4956.727379994099;4961.10700073987;4964.652474326798;5007.948330850526;4884.682495637781;4913.199476298511;4919.5080491950785;4922.384701912261;4948.455669876311;3702.38910579754;3782.2057367952625;3830.3488406970882;3927;3992.6007399260134;3828.3109040372724;3834.213986132836;3844.788536630484;3847.615238476158;3848.4419759134908;3798.4492248623933;3810.5427348718194;3812.9237415251678;3817.503724515809;3818.9809050954846;3801.8479260829536;3802.239552089593;3805.82873770681;3807;3812.65686088252;3230.3862266169585;3283.1956170738085;3301.2407146356472;3325.9168520786934;3333.2000319923286;4823.927641085386;4829.3480380148585;4848.40610273502;4867.853964381075;4875.902481950377;4294.871153865389;4304.837693822682;4314.368235376418;4338.457692788402;4344.391785150082;4995.8501244962345;5180.870478238036;5215;5228.738563071831;5237.633365664405;3596.7122630189524;3597.568291805;3601.928890887724;3602.963970360289;3625.5649322081254;5438.728063596844;5446.564274858002;5447.237386765816;5460.645058071213;5471.425500322449;3418.7948723076697;3623.1123374772824;3659.634036596319;3672.614375490535;3682.8767225995794;3663.853445862189;3680.190358121209;3688.889333320005;3689.5572531296416;3698.7041036716996;4258.5954334338185;4290.742555446684;4298.935515967263;4302.7633480158265;4314.395984562164;5165.354330708661;5174.741262936838;5194.7922083116255;5200.92198617021;5216.321878155815;1191.1899908062428;1230.9015278777676;1232.3899669663394;1242.2856857306904;1251.9186252893533;811.736185739637;835.8829763833069;843.3000609494105;846.0524212881612;847.9443093348821;4480.798364073625;4490.259107247333;4503.279475283939;4526.841560545365;4628.560286772751;5405.216243644728;5408.783648654088;5418.83743487696;5444;5445.665811876116;4631.930521042187;4652.604528615106;4652.720836749806;4664.346991421204;4672.719636821802;2723.76847967921;2725.5502842031237;2733.9179824604894;2809.339805145789;2816.788740844445;4823.5658790709;4833;4834.25966652005;4842.443119041285;4849.636277279218;5301.787928482895;5311.973440132774;5327.81352652663;5348.759305831247;5359.919601205985;4728.267118596623;4930.926036109461;4956.727379994135;4965.577925876341;4978.477259887732;5222;5223.503767142115;5231.869203269949;5232.502912223333;5258;5181.430042695376;5194.052230413595;5195.948040519546;5199.948000519947;5216.2436446714255;4754.144254034307;4831.6325000750085;4875.366202393666;4886.877828054185;4904.3379143816555;3526.4533997229446;3560.252347007054;3568.2693893461133;3587.8026708531283;3598.4602309652714;5188.455212202815;5205.479452054764;5206.245094461357;5212.192110222922;5231.346081739783;4946.455889852042;5052;5061.240813877947;5106.463821298858;5130.58955283569;4984.601231901367;5012.398512178562;5018.770401251717;5072.873178170576;5073.930272185275;4875.902481950412;4879.39007624047;4975.477574854733;4980.228064649985;5002.799888004439;4893.116150282096;5112.258722485144;5118.513741194581;5143.81083728091;5160.896782064263;5111.361079865017;5128.871518320005;5133.974330128325;5137.434882163034;5146.716930568705 07:58:24 INFO - PROCESS | 1182 | |5;yui.html;614.3641331222186;635.431288996348;688.2841844481738;692.8475735338226;703.8486725354051;12441.066919980993;12978.805317920238;13273.33633318335;13337.13308634938;13370.398332075069;12457.252564846092;12537;12825.871741282584;12844.229346239232;12899.806502902464;804.7585724282707;825.3397282174267;825.9132791056943;825.9710910118147;827.5159031966307;786.0135529909955;816.9060558035812;819.6803246733779;823.0082750285922;823.4565186976597;853.8847255620474;854.7350321400355;855.5764896376271;855.84166929118;856.6102423397339;848.3425345357398;848.3891598049395;848.5545088828353;848.7581039403772;849.8725191221305;627.1251604012423;627.2285089340137;628.4124343738619;628.8365025093509;629.0595559638369;12538.68653283666;12746.681332966657;13031.674208144777;13076.86923130766;13126.343682815821;12408.62774116778;12783.23300601967;12790.424430900632;12895.67760805978;13110.27893465859;10389.168866490663;10483.68548943533;10577.206709496819;10683.252172347939;10734.516946737416;3218.951715724266;3254.5280934264397;3262.5432439458496;3347.6150242722156;3388.4070287699556;64113.67943160254;65470;65582;67148.66425667937;67305.66347168281;9571.90428095724;9606.231501479864;9750.512474376395;9845.163161131384;9893.60425582983;18029.098545072695;18035.909820450815;18221.08894555267;18257.543561410806;18272.63454730898;6301.495880329654;6481.805545833632;6648.368405001517;6705.597664140168;6867.519273650796;3591.5331006968927;3608.711303095746;3622.005843224967;3666.7616604920595;3709.0727318170457;2793.9580906286424;2838.148555433403;2856.114604472579;2869.9282517937218;2870.956935645967;470.1490302552391;472.8014234021719;473.091664005111;476.1310608140158;477.55587303807096;561.4503969045464;566.5326105962597;572.4104172702123;589.5018709190726;592.386879579633;7189.352958233784;7591.013168288087;7731.961340193263;7858.567778772108;7969.362451004022;546.5654804430487;563.5688698145922;566.7138095261867;592.1620906417371;597.8087012156068;3582.9283414331567;3586.7625669144104;3587.5470434474078;3612.2414292998237;3771.2834561433788;54022.45977540253;64959.350406496276;65951;66328.6683566579;66517;44517;50621.49378506241;58176.70911645415;58244;60913.69543152256;50701.49298506968;51829.74085129626;52174.73912630413;52508.21237681438;53009;6940.305969403221;7275.1997280298065;7278.96360518194;7300.087489063867;7301.379382752525;36453.81773091224;37285.25429491341;37314;37948;38330.61669383271;45362.77318613386;45495.31757023581;45599;45824.770876145405;47693.33073342416;9662.420254784736;9883.159931405911;9917.107460328605;9940.254480913816;9963.601455941682;10548.578056877946;10733.946330268298;12221.75556488883;12265.448054837376;12452.003839692985;11593.24643898144;11743.706407339885;11852.229605075643;12264.202826816228;12822.557873409163;11894.405279736151;11958.711354377616;12109.33398663082;12187;12385.318807465675;11545.769084618092;11856.644300670994;11911.404429778304;12207.267563946192;12808.74382512326;9842.803143937224;10048.49757512136;10223.386596804216;10262.538185781807;10435.269531133052;9107.954460227656;9638.759031024;9859.260555458226;9871.457069860939;9956.2532810041 07:58:24 INFO - PROCESS | 1182 | __end_tp_report 07:58:24 INFO - PROCESS | 1182 | __start_cc_report 07:58:24 INFO - PROCESS | 1182 | _x_x_mozilla_cycle_collect,344 07:58:24 INFO - PROCESS | 1182 | __end_cc_report 07:58:24 INFO - PROCESS | 1182 | __startTimestamp1483545504327__endTimestamp 07:58:24 INFO - PROCESS | 1182 | 07:58:24 INFO - PROCESS | 1182 | ------- Summary: start ------- 07:58:24 INFO - PROCESS | 1182 | Number of tests: 6 07:58:24 INFO - PROCESS | 1182 | 07:58:24 INFO - PROCESS | 1182 | [#0] dojo.html Cycles:165 Average:4710.11 Median:4820.69 stddev:503.77 (10.5%) stddev-sans-first:475.04 07:58:24 INFO - PROCESS | 1182 | Values: 2517.3 2547.1 2583.8 2594.4 2629.2 4735.4 4782.4 4792.4 4803.8 4808.4 4741.1 4758.7 4819.1 4820.9 4876.8 4347.6 4403.0 4408.7 4438.4 4500.6 4020.4 4521.5 4527.8 4537.3 4542.1 4377.7 4395.7 4409.1 4433.7 4496.0 4348.0 4389.4 4390.8 4414.7 4468.3 4372.8 4374.0 4393.0 4394.3 4401.9 4700.9 4736.3 4757.5 4782.3 4788.6 4939.6 4942.3 4997.7 5021.5 5026.5 5033.1 5047.5 5048.8 5065.1 5067.7 4744.4 4758.0 4768.0 4775.6 4798.8 5080.7 5103.0 5106.6 5171.4 5180.9 4911.8 4942.5 4947.4 4970.3 4990.8 4998.4 5046.2 5047.1 5054.6 5059.5 5067.8 5090.2 5115.4 5164.1 5172.0 5041.3 5094.5 5104.2 5111.6 5143.4 4163.4 4185.6 4292.5 4293.5 4314.3 3675.8 3680.1 3702.5 3735.2 3768.7 4475.1 4479.7 4480.3 4515.6 4519.3 5000.5 5174.3 5176.7 5181.8 5183.7 4376.0 4442.1 4446.0 4454.5 4454.7 4550.9 4563.6 4567.5 4577.3 4580.6 4809.8 4810.1 4815.0 4815.9 4828.3 5087.7 5093.9 5098.9 5116.8 5125.9 4801.8 4815.3 4817.7 4820.7 4820.9 4900.3 5012.9 5129.4 5157.8 5173.2 5097.2 5105.5 5124.1 5154.5 5179.6 4993.4 5021.4 5024.8 5033.0 5054.4 4891.6 4936.3 4947.2 4963.7 5000.9 4853.9 4864.8 4883.1 4895.4 4925.9 5044.3 5047.7 5049.0 5057.8 5059.3 4781.9 4810.4 4824.3 4875.1 4969.5 07:58:24 INFO - PROCESS | 1182 | 07:58:24 INFO - PROCESS | 1182 | [#1] ext.html Cycles:180 Average:43360.99 Median:352824.50 stddev:74458.46 (21.1%) stddev-sans-first:74597.87 07:58:24 INFO - PROCESS | 1182 | Values: 522.8 538.9 540.8 541.8 545.7 39122.4 41904.8 41925.2 41985.0 45813.3 41478.8 42030.4 42034.2 42133.4 42176.6 7655.6 7861.1 7888.7 9728.3 10115.1 9652.6 9663.5 9716.5 9736.7 9744.9 9737.9 9815.3 9820.6 9853.2 9855.8 9714.7 9724.8 9759.4 9759.8 9760.3 9658.1 9677.4 9702.4 9748.1 9791.9 34534.0 34743.1 34794.0 34814.5 34835.5 3552.8 3601.7 3607.5 3622.5 3646.2 26692.3 26818.2 27033.0 27147.5 27373.6 3147.4 3149.8 3203.4 3287.0 3293.9 241311.8 241980.0 242893.0 243582.0 243595.0 46454.5 46562.5 46722.8 46733.3 46738.0 49322.0 49335.3 49374.5 49393.5 49533.8 11961.8 12266.8 12268.0 12300.3 12318.2 8957.9 9142.4 9492.1 9636.3 9739.0 15894.1 15925.8 16015.4 16047.5 16128.9 6404.1 6560.8 6594.0 6653.9 6773.6 775.1 793.4 798.4 799.7 808.1 27315.0 28607.3 28848.7 28880.3 29248.0 959.2 961.9 973.5 992.2 1061.3 14850.2 15447.0 15473.8 15578.9 15688.1 351353.0 352248.0 352634.0 353015.0 355040.0 53051.0 53244.0 53774.7 53864.5 54094.7 1203.5 1232.0 1239.5 1246.0 1249.4 25888.0 27006.5 27831.9 28050.3 28053.0 44397.0 44691.3 44867.3 44894.3 44982.6 240726.0 241749.0 242080.0 242611.0 242648.0 23227.7 23911.0 24101.6 25310.6 26362.7 35242.3 35416.6 37173.8 37510.6 38751.2 32676.7 32684.3 32772.2 33079.2 33222.5 31272.2 31546.8 31549.4 32239.4 32375.5 30973.7 31279.0 31518.8 31678.4 31979.8 27463.6 28074.3 29442.4 29558.7 29685.4 23085.0 23107.9 23166.3 23339.8 23425.5 07:58:24 INFO - PROCESS | 1182 | 07:58:24 INFO - PROCESS | 1182 | [#2] jquery.html Cycles:180 Average:26098.04 Median:26321.99 stddev:74713.61 (283.8%) stddev-sans-first:74898.21 07:58:24 INFO - PROCESS | 1182 | Values: 358.3 361.6 364.0 370.5 384.2 16361.5 16427.0 17718.4 17782.3 17790.6 17553.5 17858.8 17940.8 17962.3 18051.8 4871.2 5137.0 5141.4 5145.4 5146.4 4923.5 5024.1 5037.0 5112.3 5120.5 5042.5 5048.8 5051.7 5056.9 5063.9 4948.0 4979.6 5028.3 5036.3 5049.7 4489.6 4504.1 4531.3 4540.3 4542.0 21189.5 21485.8 21497.0 21569.8 21656.5 2190.8 2291.1 2320.2 2322.2 2342.8 13035.4 13718.0 13968.8 14298.6 14380.7 1712.7 1732.4 1737.6 1759.4 1761.5 71827.3 72347.3 72628.0 74153.3 74858.6 9410.5 9591.3 9723.9 9965.4 10004.7 13146.8 13152.7 13184.2 13191.2 13282.5 6963.8 7176.0 7206.7 7332.0 7382.4 6821.6 6870.3 7016.1 7026.9 7042.0 6171.6 6271.8 6284.9 6436.3 6476.2 1755.5 1766.1 1768.7 1794.6 1800.8 819.0 819.8 822.3 829.5 834.9 14195.0 14941.3 15005.8 15124.8 15178.7 815.9 820.6 825.5 829.6 840.2 8333.4 8884.5 9199.6 9352.2 9413.3 447817.0 449629.0 455242.0 456424.0 464425.0 71221.0 71301.0 72314.5 73186.6 73337.0 942.4 959.8 989.0 990.9 994.7 12998.4 13370.3 13374.7 14068.9 14112.6 34664.3 34683.5 34959.5 35382.3 35457.5 47772.8 48964.5 49627.5 58286.0 58873.1 7525.9 7703.7 7756.3 7945.2 7955.9 8181.8 11727.9 12137.9 12256.5 12604.9 9995.9 10256.3 10265.9 10358.4 10600.2 10546.3 10640.6 10652.4 10685.3 10688.1 10214.0 10740.4 10791.3 10811.5 10919.2 7575.6 7638.3 7652.7 7759.5 7894.7 6868.2 7197.3 7634.8 9099.5 10449.9 07:58:24 INFO - PROCESS | 1182 | 07:58:24 INFO - PROCESS | 1182 | [#3] mootools.html Cycles:180 Average:4505.67 Median:5267.99 stddev:2368.07 (45.0%) stddev-sans-first:2362.41 07:58:24 INFO - PROCESS | 1182 | Values: 1293.8 1315.9 1317.1 1321.1 1331.1 5973.9 6214.4 6613.1 6881.8 6978.8 6433.7 6609.4 6614.9 6780.6 6791.0 1992.5 2034.3 2044.4 2044.7 2054.7 1981.8 1997.6 2045.5 2049.4 2062.2 2087.7 2099.8 2106.8 2108.5 2115.6 1986.5 2000.7 2002.6 2009.3 2010.5 2059.4 2068.8 2074.1 2082.7 2084.3 6927.2 6988.8 7007.8 7025.6 7044.9 4057.9 4208.3 4211.0 4215.4 4225.3 2622.5 2765.9 2838.8 2848.0 2848.0 1082.0 1085.0 1103.4 1129.1 1130.6 8790.3 8802.6 8822.3 8843.1 8844.7 3586.0 3615.1 3640.9 3651.6 3674.2 7304.1 7311.7 7345.4 7352.8 7364.8 4156.4 4193.0 4253.9 4255.5 4256.1 3828.1 3926.5 3973.5 3982.1 3990.7 2964.7 2982.0 3050.1 3053.4 3068.8 870.6 884.3 892.4 919.5 924.9 806.9 808.9 812.5 815.3 826.9 4498.4 4565.1 4589.0 4722.1 4780.4 875.8 904.6 917.7 930.0 930.6 3260.8 3318.5 3387.6 3395.1 3444.6 8002.6 8100.0 8206.3 8211.8 8246.4 8097.5 8114.8 8124.2 8124.3 8154.1 6408.8 6432.3 6489.5 6582.3 6603.1 4703.9 4731.4 4779.2 4811.7 4857.8 7390.0 7439.6 7459.9 7521.5 7524.9 7191.2 7377.5 7513.8 7586.4 7598.4 5972.1 6062.2 6092.1 6093.3 6134.2 6475.3 6545.6 6562.9 6563.6 6584.0 5166.9 5940.9 5980.2 6022.4 6035.8 5908.6 5918.1 6003.6 6068.8 6108.2 5369.1 5448.5 5484.6 5492.6 5496.2 4091.6 4154.8 4217.7 4269.1 4354.1 4102.7 4169.3 4194.1 4253.4 4291.7 07:58:24 INFO - PROCESS | 1182 | 07:58:24 INFO - PROCESS | 1182 | [#4] prototype.html Cycles:180 Average:4244.72 Median:4858.75 stddev:1252.49 (25.8%) stddev-sans-first:1220.84 07:58:24 INFO - PROCESS | 1182 | Values: 317.9 320.9 323.2 324.3 328.8 4954.4 4956.7 4961.1 4964.7 5007.9 4884.7 4913.2 4919.5 4922.4 4948.5 3702.4 3782.2 3830.3 3927.0 3992.6 3828.3 3834.2 3844.8 3847.6 3848.4 3798.4 3810.5 3812.9 3817.5 3819.0 3801.8 3802.2 3805.8 3807.0 3812.7 3230.4 3283.2 3301.2 3325.9 3333.2 4823.9 4829.3 4848.4 4867.9 4875.9 4294.9 4304.8 4314.4 4338.5 4344.4 4995.9 5180.9 5215.0 5228.7 5237.6 3596.7 3597.6 3601.9 3603.0 3625.6 5438.7 5446.6 5447.2 5460.6 5471.4 3418.8 3623.1 3659.6 3672.6 3682.9 3663.9 3680.2 3688.9 3689.6 3698.7 4258.6 4290.7 4298.9 4302.8 4314.4 5165.4 5174.7 5194.8 5200.9 5216.3 1191.2 1230.9 1232.4 1242.3 1251.9 811.7 835.9 843.3 846.1 847.9 4480.8 4490.3 4503.3 4526.8 4628.6 5405.2 5408.8 5418.8 5444.0 5445.7 4631.9 4652.6 4652.7 4664.3 4672.7 2723.8 2725.6 2733.9 2809.3 2816.8 4823.6 4833.0 4834.3 4842.4 4849.6 5301.8 5312.0 5327.8 5348.8 5359.9 4728.3 4930.9 4956.7 4965.6 4978.5 5222.0 5223.5 5231.9 5232.5 5258.0 5181.4 5194.1 5195.9 5199.9 5216.2 4754.1 4831.6 4875.4 4886.9 4904.3 3526.5 3560.3 3568.3 3587.8 3598.5 5188.5 5205.5 5206.2 5212.2 5231.3 4946.5 5052.0 5061.2 5106.5 5130.6 4984.6 5012.4 5018.8 5072.9 5073.9 4875.9 4879.4 4975.5 4980.2 5002.8 4893.1 5112.3 5118.5 5143.8 5160.9 5111.4 5128.9 5134.0 5137.4 5146.7 07:58:24 INFO - PROCESS | 1182 | 07:58:24 INFO - PROCESS | 1182 | [#5] yui.html Cycles:180 Average:14672.09 Median:50661.49 stddev:18436.94 (36.4%) stddev-sans-first:18458.44 07:58:24 INFO - PROCESS | 1182 | Values: 614.4 635.4 688.3 692.8 703.8 12441.1 12978.8 13273.3 13337.1 13370.4 12457.3 12537.0 12825.9 12844.2 12899.8 804.8 825.3 825.9 826.0 827.5 786.0 816.9 819.7 823.0 823.5 853.9 854.7 855.6 855.8 856.6 848.3 848.4 848.6 848.8 849.9 627.1 627.2 628.4 628.8 629.1 12538.7 12746.7 13031.7 13076.9 13126.3 12408.6 12783.2 12790.4 12895.7 13110.3 10389.2 10483.7 10577.2 10683.3 10734.5 3219.0 3254.5 3262.5 3347.6 3388.4 64113.7 65470.0 65582.0 67148.7 67305.7 9571.9 9606.2 9750.5 9845.2 9893.6 18029.1 18035.9 18221.1 18257.5 18272.6 6301.5 6481.8 6648.4 6705.6 6867.5 3591.5 3608.7 3622.0 3666.8 3709.1 2794.0 2838.1 2856.1 2869.9 2871.0 470.1 472.8 473.1 476.1 477.6 561.5 566.5 572.4 589.5 592.4 7189.4 7591.0 7732.0 7858.6 7969.4 546.6 563.6 566.7 592.2 597.8 3582.9 3586.8 3587.5 3612.2 3771.3 54022.5 64959.4 65951.0 66328.7 66517.0 44517.0 50621.5 58176.7 58244.0 60913.7 50701.5 51829.7 52174.7 52508.2 53009.0 6940.3 7275.2 7279.0 7300.1 7301.4 36453.8 37285.3 37314.0 37948.0 38330.6 45362.8 45495.3 45599.0 45824.8 47693.3 9662.4 9883.2 9917.1 9940.3 9963.6 10548.6 10733.9 12221.8 12265.4 12452.0 11593.2 11743.7 11852.2 12264.2 12822.6 11894.4 11958.7 12109.3 12187.0 12385.3 11545.8 11856.6 11911.4 12207.3 12808.7 9842.8 10048.5 10223.4 10262.5 10435.3 9108.0 9638.8 9859.3 9871.5 9956.3 07:58:24 INFO - PROCESS | 1182 | -------- Summary: end -------- 07:58:24 INFO - PROCESS | 1182 | 07:58:25 INFO - TEST-INFO | 1182: exit 0 07:58:25 INFO - TEST-OK | dromaeo_css | took 1119225ms 07:58:25 INFO - TEST-START | kraken 07:58:25 INFO - operating with platform_type : linux_ 07:58:25 INFO - Initialising browser for kraken test... 07:58:25 INFO - TEST-INFO | started process 1534 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphorbOV/profile http://localhost:60888/getInfo.html) 07:58:25 INFO - PROCESS | 1534 | 1483545505645 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 07:58:29 INFO - PROCESS | 1534 | __metrics Screen width/height:1600/1200 07:58:29 INFO - PROCESS | 1534 | colorDepth:24 07:58:29 INFO - PROCESS | 1534 | Browser inner width/height: 1024/697 07:58:29 INFO - PROCESS | 1534 | __metrics 07:58:29 ERROR - PROCESS | 1534 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 07:58:30 INFO - TEST-INFO | 1534: exit 0 07:58:30 INFO - Browser initialized. 07:58:30 INFO - Running cycle 1/1 for kraken test... 07:58:30 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmphorbOV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:58:42 INFO - PROCESS | 1653 | RSS: Main: 158793728 07:58:42 INFO - PROCESS | 1653 | 07:58:45 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:60888/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60888/tests/kraken/driver.html?testName=audio-beat-detection) 07:58:46 INFO - PROCESS | 1653 | RSS: Main: 164007936 07:58:46 INFO - PROCESS | 1653 | 07:58:49 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:60888/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60888/tests/kraken/driver.html?testName=audio-dft) 07:58:49 INFO - PROCESS | 1653 | RSS: Main: 163639296 07:58:49 INFO - PROCESS | 1653 | 07:58:52 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:60888/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60888/tests/kraken/driver.html?testName=audio-fft) 07:58:53 INFO - PROCESS | 1653 | RSS: Main: 159784960 07:58:53 INFO - PROCESS | 1653 | 07:58:55 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:60888/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60888/tests/kraken/driver.html?testName=audio-oscillator) 07:58:56 INFO - PROCESS | 1653 | RSS: Main: 160505856 07:58:56 INFO - PROCESS | 1653 | 07:58:58 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:60888/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60888/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:58:58 INFO - PROCESS | 1653 | RSS: Main: 160808960 07:58:58 INFO - PROCESS | 1653 | 07:59:02 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:60888/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60888/tests/kraken/driver.html?testName=imaging-darkroom) 07:59:02 INFO - PROCESS | 1653 | RSS: Main: 165359616 07:59:02 INFO - PROCESS | 1653 | 07:59:06 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:60888/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60888/tests/kraken/driver.html?testName=imaging-desaturate) 07:59:06 INFO - PROCESS | 1653 | RSS: Main: 161697792 07:59:06 INFO - PROCESS | 1653 | 07:59:09 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:60888/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60888/tests/kraken/driver.html?testName=json-parse-financial) 07:59:10 INFO - PROCESS | 1653 | RSS: Main: 162820096 07:59:10 INFO - PROCESS | 1653 | 07:59:12 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:60888/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60888/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:59:12 INFO - PROCESS | 1653 | RSS: Main: 162705408 07:59:12 INFO - PROCESS | 1653 | 07:59:14 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:60888/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60888/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:59:15 INFO - PROCESS | 1653 | RSS: Main: 163151872 07:59:15 INFO - PROCESS | 1653 | 07:59:17 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:60888/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60888/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:59:18 INFO - PROCESS | 1653 | RSS: Main: 163573760 07:59:18 INFO - PROCESS | 1653 | 07:59:21 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:60888/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60888/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:59:21 INFO - PROCESS | 1653 | RSS: Main: 163770368 07:59:21 INFO - PROCESS | 1653 | 07:59:24 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:60888/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60888/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:59:25 INFO - PROCESS | 1653 | RSS: Main: 166785024 07:59:25 INFO - PROCESS | 1653 | 07:59:27 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:60888/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60888/tests/kraken/driver.html?testName=ai-astar) 07:59:27 INFO - PROCESS | 1653 | RSS: Main: 167915520 07:59:27 INFO - PROCESS | 1653 | 07:59:27 INFO - PROCESS | 1653 | __start_tp_report 07:59:27 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 07:59:27 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 07:59:27 INFO - PROCESS | 1653 | |i|pagename|runs| 07:59:27 INFO - PROCESS | 1653 | |0;ai-astar;108;118;115;116;115;116;117;116;115;117 07:59:27 INFO - PROCESS | 1653 | |1;audio-beat-detection;155;131;128;167;128;128;128;134;153;137 07:59:27 INFO - PROCESS | 1653 | |2;audio-dft;164;171;166;176;162;162;163;164;164;168 07:59:27 INFO - PROCESS | 1653 | |3;audio-fft;76;76;76;107;77;76;76;77;101;76 07:59:27 INFO - PROCESS | 1653 | |4;audio-oscillator;86;85;106;85;85;84;106;84;85;111 07:59:27 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;118;118;119;118;118;118;123;118;118;118 07:59:27 INFO - PROCESS | 1653 | |6;imaging-darkroom;151;151;151;149;152;151;151;151;152;151 07:59:27 INFO - PROCESS | 1653 | |7;imaging-desaturate;96;97;95;97;95;96;96;97;95;95 07:59:27 INFO - PROCESS | 1653 | |8;json-parse-financial;66;64;64;65;66;66;65;68;68;66 07:59:27 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;67;67;66;67;67;67;70;68;68;67 07:59:27 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;85;85;86;86;86;84;90;91;84;85 07:59:27 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;142;149;137;137;135;138;135;136;209;136 07:59:27 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;179;175;175;175;176;175;178;176;175;173 07:59:27 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;75;70;73;68;70;68;68;69;73;67 07:59:27 INFO - PROCESS | 1653 | __end_tp_report 07:59:27 INFO - PROCESS | 1653 | __start_cc_report 07:59:27 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,807 07:59:27 INFO - PROCESS | 1653 | __end_cc_report 07:59:27 INFO - PROCESS | 1653 | __startTimestamp1483545567491__endTimestamp 07:59:27 INFO - PROCESS | 1653 | 07:59:27 INFO - PROCESS | 1653 | ------- Summary: start ------- 07:59:27 INFO - PROCESS | 1653 | Number of tests: 14 07:59:27 INFO - PROCESS | 1653 | 07:59:27 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:115.30 Median:116.00 stddev:2.75 (2.4%) stddev-sans-first:1.05 07:59:27 INFO - PROCESS | 1653 | Values: 108.0 118.0 115.0 116.0 115.0 116.0 117.0 116.0 115.0 117.0 07:59:27 INFO - PROCESS | 1653 | 07:59:27 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:138.90 Median:135.50 stddev:14.19 (10.5%) stddev-sans-first:13.81 07:59:27 INFO - PROCESS | 1653 | Values: 155.0 131.0 128.0 167.0 128.0 128.0 128.0 134.0 153.0 137.0 07:59:27 INFO - PROCESS | 1653 | 07:59:27 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:166.00 Median:165.00 stddev:4.50 (2.7%) stddev-sans-first:4.71 07:59:27 INFO - PROCESS | 1653 | Values: 164.0 171.0 166.0 176.0 162.0 162.0 163.0 164.0 164.0 168.0 07:59:27 INFO - PROCESS | 1653 | 07:59:27 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:81.80 Median:76.00 stddev:11.79 (15.5%) stddev-sans-first:12.32 07:59:27 INFO - PROCESS | 1653 | Values: 76.0 76.0 76.0 107.0 77.0 76.0 76.0 77.0 101.0 76.0 07:59:27 INFO - PROCESS | 1653 | 07:59:27 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:91.70 Median:85.00 stddev:11.12 (13.1%) stddev-sans-first:11.60 07:59:27 INFO - PROCESS | 1653 | Values: 86.0 85.0 106.0 85.0 85.0 84.0 106.0 84.0 85.0 111.0 07:59:27 INFO - PROCESS | 1653 | 07:59:27 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:118.00 stddev:1.58 (1.3%) stddev-sans-first:1.66 07:59:27 INFO - PROCESS | 1653 | Values: 118.0 118.0 119.0 118.0 118.0 118.0 123.0 118.0 118.0 118.0 07:59:27 INFO - PROCESS | 1653 | 07:59:27 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:151.00 Median:151.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 07:59:27 INFO - PROCESS | 1653 | Values: 151.0 151.0 151.0 149.0 152.0 151.0 151.0 151.0 152.0 151.0 07:59:27 INFO - PROCESS | 1653 | 07:59:27 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 07:59:27 INFO - PROCESS | 1653 | Values: 96.0 97.0 95.0 97.0 95.0 96.0 96.0 97.0 95.0 95.0 07:59:27 INFO - PROCESS | 1653 | 07:59:27 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:65.80 Median:66.00 stddev:1.40 (2.1%) stddev-sans-first:1.48 07:59:27 INFO - PROCESS | 1653 | Values: 66.0 64.0 64.0 65.0 66.0 66.0 65.0 68.0 68.0 66.0 07:59:27 INFO - PROCESS | 1653 | 07:59:27 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:67.00 stddev:1.07 (1.6%) stddev-sans-first:1.13 07:59:27 INFO - PROCESS | 1653 | Values: 67.0 67.0 66.0 67.0 67.0 67.0 70.0 68.0 68.0 67.0 07:59:27 INFO - PROCESS | 1653 | 07:59:27 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:86.00 stddev:2.39 (2.8%) stddev-sans-first:2.50 07:59:27 INFO - PROCESS | 1653 | Values: 85.0 85.0 86.0 86.0 86.0 84.0 90.0 91.0 84.0 85.0 07:59:27 INFO - PROCESS | 1653 | 07:59:27 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:145.40 Median:137.50 stddev:22.75 (16.5%) stddev-sans-first:24.10 07:59:27 INFO - PROCESS | 1653 | Values: 142.0 149.0 137.0 137.0 135.0 138.0 135.0 136.0 209.0 136.0 07:59:27 INFO - PROCESS | 1653 | 07:59:27 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.70 Median:175.50 stddev:1.70 (1.0%) stddev-sans-first:1.32 07:59:27 INFO - PROCESS | 1653 | Values: 179.0 175.0 175.0 175.0 176.0 175.0 178.0 176.0 175.0 173.0 07:59:27 INFO - PROCESS | 1653 | 07:59:27 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.10 Median:70.00 stddev:2.69 (3.8%) stddev-sans-first:2.19 07:59:27 INFO - PROCESS | 1653 | Values: 75.0 70.0 73.0 68.0 70.0 68.0 68.0 69.0 73.0 67.0 07:59:27 INFO - PROCESS | 1653 | -------- Summary: end -------- 07:59:27 INFO - PROCESS | 1653 | 07:59:28 INFO - TEST-INFO | 1653: exit 0 07:59:28 INFO - TEST-OK | kraken | took 63496ms 07:59:28 INFO - SUITE-END | took 1182s 07:59:29 INFO - Completed test suite (00:19:43) 07:59:29 INFO - javascript benchmark 07:59:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6232.693973554867, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2517.295157355941, 2547.057588692184, 2583.767460928517, 2594.377349436136, 2629.2375211188746, 4735.360726301957, 4782.402199725035, 4792.353032340633, 4803.783829727662, 4808.447028591713, 4741.122892264933, 4758.666893317469, 4819.1325561398935, 4820.879478013051, 4876.756162191885, 4347.586979236975, 4403.0, 4408.713433626804, 4438.423005009345, 4500.572445617661, 4020.4170395292663, 4521.547845215485, 4527.773611319437, 4537.31940208968, 4542.09158168366, 4377.737335759833, 4395.7362558246605, 4409.11817636474, 4433.667474939376, 4496.0, 4348.043430445297, 4389.407429996942, 4390.846320378803, 4414.713043652152, 4468.285074388083, 4372.846950356722, 4373.956260437419, 4393.0, 4394.340848872663, 4401.867943961686, 4700.882477938045, 4736.2895565665085, 4757.452892917289, 4782.33047373368, 4788.592969597588, 4939.629527785431, 4942.283368911488, 4997.6501644884875, 5021.472745361758, 5026.522480364396, 5033.094043072246, 5047.520485553903, 5048.7980480780725, 5065.11360511909, 5067.746612669389, 4744.406949131324, 4758.0, 4767.95232047682, 4775.641826863, 4798.760061996956, 5080.7205603692155, 5102.974485127551, 5106.591472682177, 5171.3535808024, 5180.948190518122, 4911.8280860169725, 4942.5304596063315, 4947.406311242602, 4970.304157417964, 4990.800367985313, 4998.350214472095, 5046.243063540498, 5047.116754567936, 5054.570361519312, 5059.519345662156, 5067.822626208139, 5090.211017292326, 5115.38615366151, 5164.0962831505085, 5172.0, 5041.344625198774, 5094.490550944876, 5104.2343648453025, 5111.642185047085, 5143.408508021551, 4163.39630753539, 4185.644220241253, 4292.506361768436, 4293.527711951683, 4314.331278651814, 3675.8162091895833, 3680.0799800049986, 3702.5371828521434, 3735.1782607826235, 3768.660820526166, 4475.127350166751, 4479.664025198123, 4480.260756975128, 4515.571020753023, 4519.29950857611, 5000.524950129732, 5174.275601415805, 5176.689398636094, 5181.844544663666, 5183.714895680699, 4375.956240437618, 4442.133783912106, 4445.955540444619, 4454.532274111237, 4454.732716037048, 4550.88622784433, 4563.589276965089, 4567.5432456754725, 4577.267637178102, 4580.633549316047, 4809.78355973982, 4810.134175848311, 4815.036992601564, 4815.892344760655, 4828.348172996671, 5087.694738315713, 5093.853882876323, 5098.898022039464, 5116.846494605168, 5125.948740512547, 4801.783919723691, 4815.253635686474, 4817.710937343771, 4820.68665536739, 4820.903581928412, 4900.26496025599, 5012.924806127838, 5129.410117836496, 5157.8452646420665, 5173.22401639742, 5097.235414687826, 5105.5149760772665, 5124.12889808726, 5154.5103215194495, 5179.611529135254, 4993.425756038102, 5021.447640759587, 5024.799008039638, 5033.043721692867, 5054.368203974504, 4891.559759621651, 4936.333594964633, 4947.1589829729755, 4963.726995015309, 5000.949990500194, 4853.878653033702, 4864.781084851261, 4883.145449546386, 4895.388076490439, 4925.876853078702, 5044.319016932667, 5047.722375269395, 5049.0, 5057.8482645519225, 5059.3169922061525, 4781.9043619128115, 4810.350602668595, 4824.324594556835, 4875.098106850244, 4969.527894850128], "value": 4676.548766957821, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [522.7882707503461, 538.9164679474683, 540.8404520666403, 541.8455740114066, 545.68623041751, 39122.413163802565, 41904.790476047616, 41925.16149677009, 41985.0, 45813.31280030794, 41478.79260603693, 42030.36954445678, 42034.15931681372, 42133.36799947995, 42176.578234217726, 7655.578943158138, 7861.095973962982, 7888.723894663688, 9728.270379721549, 10115.14021308186, 9652.613895444209, 9663.468509231989, 9716.465594392306, 9736.707898763014, 9744.853827192563, 9737.853932191023, 9815.312928095, 9820.607175713, 9853.211743060574, 9855.753606159868, 9714.65998690046, 9724.75688107796, 9759.41443513388, 9759.756006099833, 9760.316777825556, 9658.130768230892, 9677.37097088687, 9702.369345992487, 9748.073932976356, 9791.853122203172, 34534.0, 34743.13142171466, 34794.0, 34814.477782833026, 34835.47746783775, 3552.751307408457, 3601.730573128596, 3607.549056367954, 3622.474741162543, 3646.197836475971, 26692.33269168267, 26818.195454136407, 27033.0, 27147.457050858873, 27373.589396159074, 3147.35479226758, 3149.8267595282477, 3203.3913556424204, 3287.0467564406295, 3293.901182964515, 241311.79344103343, 241980.0, 242893.0, 243582.0, 243595.0, 46454.535454645695, 46562.5343746565, 46722.76638616785, 46733.29900051502, 46738.0, 49322.0, 49335.25997110046, 49374.50625493699, 49393.50606493889, 49533.79895111034, 11961.820572691417, 12266.791977444145, 12268.018558515298, 12300.261984280973, 12318.199317044364, 8957.865632015524, 9142.405743626643, 9492.145706886413, 9636.277279204087, 9739.0, 15894.125823079841, 15925.761113583305, 16015.359385624677, 16047.518574442553, 16128.919355403148, 6404.083589723088, 6560.803175904731, 6593.967030164818, 6653.935370340722, 6773.593584384953, 775.1241097559721, 793.4208028139491, 798.3892322373389, 799.7440818938001, 808.1393316118315, 27315.0, 28607.28481787972, 28848.7115128846, 28880.292671224594, 29247.976320828668, 959.1655259923772, 961.9230461563199, 973.5424350555228, 992.2111921022804, 1061.2518174686827, 14850.183239921907, 15447.0, 15473.767893481607, 15578.922105389627, 15688.137152456724, 351353.0, 352248.0, 352634.0, 353015.0, 355040.0, 53051.0, 53244.0, 53774.7311263449, 53864.461355385945, 54094.729526352115, 1203.5426537915537, 1232.0328542094412, 1239.4980033086615, 1246.0343233993729, 1249.3565813606, 25888.0, 27006.459870802082, 27831.909258981825, 28050.2987425316, 28053.0, 44397.0, 44691.32963005623, 44867.32699009452, 44894.3265851006, 44982.55017449784, 240726.0, 241749.0, 242080.0, 242611.0, 242648.0, 23227.651585225896, 23911.0, 24101.638475423235, 25310.620340695274, 26362.736372636027, 35242.295154097286, 35416.64583354133, 37173.814130929175, 37510.62489375071, 38751.224975500896, 32676.673233267364, 32684.34631307313, 32772.180695482806, 33079.17302067467, 33222.5016624746, 31272.21819454532, 31546.842265788524, 31549.36901261916, 32239.35521289514, 32375.51436728404, 30973.69026309708, 31279.0, 31518.842405787826, 31678.36643267168, 31979.84010079935, 27463.626818658588, 28074.2981425466, 29442.411151777273, 29558.704412956457, 29685.40629187361, 23085.0, 23107.88446057759, 23166.34101345899, 23339.76660233444, 23425.531489370456], "value": 17135.769407432952, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.2566175186488, 361.62571738250915, 363.9781613103214, 370.5016752467933, 384.17019238444965, 16361.509154725363, 16427.0, 17718.379856705003, 17782.288708451648, 17790.64418711625, 17553.473395798115, 17858.821411785877, 17940.770661280996, 17962.281508739634, 18051.819481805178, 4871.220604703248, 5137.0, 5141.357330333708, 5145.382554093495, 5146.40816306124, 4923.507649235084, 5024.070546948826, 5036.974815125919, 5112.284280200774, 5120.539151476366, 5042.520960508764, 5048.823291184809, 5051.747412629372, 5056.898862022757, 5063.898722025576, 4948.0, 4979.601631869442, 5028.346314979048, 5036.294918711384, 5049.72226527539, 4489.551044895485, 4504.054148628792, 4531.297648864432, 4540.27355623102, 4542.0234649550175, 21189.470263243387, 21485.785142148536, 21497.032633531373, 21569.78430215709, 21656.458588535254, 2190.835687323457, 2291.0721157931066, 2320.1995311617466, 2322.198841399714, 2342.7657234276608, 13035.413406396736, 13718.039737218398, 13968.790468142986, 14298.64253393663, 14380.712385752226, 1712.7174016287297, 1732.385003323827, 1737.6177241006958, 1759.366628013914, 1761.462753860072, 71827.28172718258, 72347.27652723511, 72628.0, 74153.25846741571, 74858.62570687111, 9410.529473526296, 9591.280653950982, 9723.902760972442, 9965.40207587547, 10004.749881253027, 13146.802797958038, 13152.736945261233, 13184.208947463183, 13191.208527488381, 13282.535111271252, 6963.825904352431, 7175.96412017947, 7206.711731530785, 7331.963340183265, 7382.372498337594, 6821.556598821061, 6870.282220319014, 7016.0528328676, 7026.894596581055, 7042.0, 6171.59884607499, 6271.843203919847, 6284.905726414107, 6436.3241859605005, 6476.190476190476, 1755.5260079778643, 1766.143420441085, 1768.6816373052975, 1794.596215851423, 1800.8199180081888, 818.9631466583899, 819.8073452738602, 822.268181318627, 829.4649950781712, 834.8789425533264, 14195.006349555639, 14941.252937353089, 15005.77491337609, 15124.848751512563, 15178.696426071638, 815.8531464336357, 820.5938060660012, 825.5264353129635, 829.618375547243, 840.1598401598402, 8333.374996875258, 8884.511351875708, 9199.63201471947, 9352.158305752515, 9413.275336064082, 447817.0, 449629.0, 455242.0, 456424.0, 464425.0, 71221.0, 71301.0, 72314.49169574764, 73186.63406683039, 73337.0, 942.4167398770132, 959.7744530035436, 989.0159291504855, 990.9306348555532, 994.7363948553639, 12998.350082495648, 13370.331483425594, 13374.665633358854, 14068.859311406755, 14112.647183820487, 34664.30671386508, 34683.4797478033, 34959.475607866414, 35382.33882578775, 35457.46813797847, 47772.761136194094, 48964.510354895996, 49627.50372496229, 58286.0, 58873.11690324734, 7525.88711169322, 7703.691852325845, 7756.263155000266, 7945.245201705829, 7955.920440795518, 8181.79545511367, 11727.882721172678, 12137.939310303393, 12256.509739610672, 12604.873951260737, 9995.900040999497, 10256.282060255711, 10265.897341026493, 10358.430286334324, 10600.151987841109, 10546.314489558154, 10640.627578034731, 10652.400861143213, 10685.3054551457, 10688.144948404264, 10214.033054217722, 10740.355578665305, 10791.298565593212, 10811.513481893491, 10919.19674874478, 7575.583342916192, 7638.312551870358, 7652.693892244248, 7759.495632783851, 7894.723684671009, 6868.210155832143, 7197.280271972971, 7634.847303054019, 9099.49952752605, 10449.895501045195], "value": 8259.94199865708, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1293.7994610835324, 1315.9473621055151, 1317.0780453682426, 1321.1412581821814, 1331.0866053801822, 5973.940260597393, 6214.440700336969, 6613.14029176207, 6881.759138430156, 6978.8255293617685, 6433.710483028263, 6609.372109649587, 6614.933850661492, 6780.55926364786, 6791.049253104569, 1992.452075679189, 2034.298167132337, 2044.4479990402583, 2044.672852343618, 2054.6609809381434, 1981.8018198180212, 1997.5805080933021, 2045.549979004624, 2049.415916463808, 2062.236972320236, 2087.7390326209224, 2099.84251181162, 2106.7682554918947, 2108.5361220531536, 2115.555733296002, 1986.503374156461, 2000.679891217413, 2002.6395248855201, 2009.2867032203576, 2010.507425680703, 2059.423361458794, 2068.803463670964, 2074.087401543316, 2082.6563617003176, 2084.2809230815346, 6927.168739751211, 6988.790336289869, 7007.789766307019, 7025.648717564152, 7044.894326585106, 4057.857974970862, 4208.284591619432, 4211.031462763551, 4215.367694845767, 4225.34507151389, 2622.5148347555764, 2765.9170224893287, 2838.815476993989, 2847.957280640792, 2847.985760071207, 1081.9729506762314, 1084.9945750271197, 1103.42070413033, 1129.074159189465, 1130.5647325779553, 8790.252828509585, 8802.603882825224, 8822.250108740765, 8843.0714774949, 8844.73465796027, 3586.0, 3615.096225943514, 3640.927181456409, 3651.6165802590876, 3674.228412033503, 7304.086989126359, 7311.670974806147, 7345.412367010626, 7352.816179595446, 7364.77905662831, 4156.418101465797, 4192.979035104805, 4253.893652658709, 4255.510616279167, 4256.127493863751, 3828.062124779447, 3926.5484469285825, 3973.5033120859894, 3982.1239327348517, 3990.660793832557, 2964.7183517565795, 2981.9701802981695, 3050.084974507639, 3053.435114503824, 3068.800527965675, 870.56906831119, 884.2704768565959, 892.3708785306344, 919.5264438814016, 924.8658944453017, 806.8910697055823, 808.9393295502861, 812.5490352854105, 815.3273549321833, 826.8635675113659, 4498.367888390437, 4565.132624801277, 4588.977055114769, 4722.126406614787, 4780.402449693788, 875.8029443375317, 904.5612877754284, 917.7109210598641, 930.0327659234321, 930.6463543853428, 3260.7717459778064, 3318.502224666271, 3387.5596172497417, 3395.117269509896, 3444.6383129771516, 8002.639881205359, 8100.0, 8206.302464290482, 8211.753647390588, 8246.422750407533, 8097.514149151069, 8114.756557303291, 8124.187581241828, 8124.268815806606, 8154.062282837431, 6408.839779005469, 6432.2602900667025, 6489.545731798823, 6582.341765823475, 6603.108580341688, 4703.905921881612, 4731.361266229015, 4779.1636463619425, 4811.735354555393, 4857.781399836945, 7389.963050184715, 7439.628018599156, 7459.850802983801, 7521.4734968551675, 7524.924750752422, 7191.173015103121, 7377.4835761498325, 7513.774586762406, 7586.355159811478, 7598.430117741081, 5972.104184372379, 6062.211912451353, 6092.147099406176, 6093.268807743099, 6134.171886795404, 6475.287718350884, 6545.639989800607, 6562.901556476561, 6563.638999854863, 6584.045313429621, 5166.870828229325, 5940.881182376242, 5980.222571065908, 6022.397760223943, 6035.758569657164, 5908.645481271137, 5918.082697181943, 6003.5797494174985, 6068.817935461943, 6108.205933228652, 5369.1140961740875, 5448.45515448452, 5484.588655850907, 5492.615516913777, 5496.1755736639825, 4091.5703851096396, 4154.813033413564, 4217.662586992972, 4269.082147338338, 4354.107407981292, 4102.733322334038, 4169.2703776839535, 4194.0563373240775, 4253.404523366793, 4291.656667466657], "value": 3721.6247562501644, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.90481790232644, 320.8844815866289, 323.17267794446207, 324.29951305180816, 328.76657573123083, 4954.430240522341, 4956.727379994099, 4961.10700073987, 4964.652474326798, 5007.948330850526, 4884.682495637781, 4913.199476298511, 4919.5080491950785, 4922.384701912261, 4948.455669876311, 3702.38910579754, 3782.2057367952625, 3830.3488406970882, 3927.0, 3992.6007399260134, 3828.3109040372724, 3834.213986132836, 3844.788536630484, 3847.615238476158, 3848.4419759134908, 3798.4492248623933, 3810.5427348718194, 3812.9237415251678, 3817.503724515809, 3818.9809050954846, 3801.8479260829536, 3802.239552089593, 3805.82873770681, 3807.0, 3812.65686088252, 3230.3862266169585, 3283.1956170738085, 3301.2407146356472, 3325.9168520786934, 3333.2000319923286, 4823.927641085386, 4829.3480380148585, 4848.40610273502, 4867.853964381075, 4875.902481950377, 4294.871153865389, 4304.837693822682, 4314.368235376418, 4338.457692788402, 4344.391785150082, 4995.8501244962345, 5180.870478238036, 5215.0, 5228.738563071831, 5237.633365664405, 3596.7122630189524, 3597.568291805, 3601.928890887724, 3602.963970360289, 3625.5649322081254, 5438.728063596844, 5446.564274858002, 5447.237386765816, 5460.645058071213, 5471.425500322449, 3418.7948723076697, 3623.1123374772824, 3659.634036596319, 3672.614375490535, 3682.8767225995794, 3663.853445862189, 3680.190358121209, 3688.889333320005, 3689.5572531296416, 3698.7041036716996, 4258.5954334338185, 4290.742555446684, 4298.935515967263, 4302.7633480158265, 4314.395984562164, 5165.354330708661, 5174.741262936838, 5194.7922083116255, 5200.92198617021, 5216.321878155815, 1191.1899908062428, 1230.9015278777676, 1232.3899669663394, 1242.2856857306904, 1251.9186252893533, 811.736185739637, 835.8829763833069, 843.3000609494105, 846.0524212881612, 847.9443093348821, 4480.798364073625, 4490.259107247333, 4503.279475283939, 4526.841560545365, 4628.560286772751, 5405.216243644728, 5408.783648654088, 5418.83743487696, 5444.0, 5445.665811876116, 4631.930521042187, 4652.604528615106, 4652.720836749806, 4664.346991421204, 4672.719636821802, 2723.76847967921, 2725.5502842031237, 2733.9179824604894, 2809.339805145789, 2816.788740844445, 4823.5658790709, 4833.0, 4834.25966652005, 4842.443119041285, 4849.636277279218, 5301.787928482895, 5311.973440132774, 5327.81352652663, 5348.759305831247, 5359.919601205985, 4728.267118596623, 4930.926036109461, 4956.727379994135, 4965.577925876341, 4978.477259887732, 5222.0, 5223.503767142115, 5231.869203269949, 5232.502912223333, 5258.0, 5181.430042695376, 5194.052230413595, 5195.948040519546, 5199.948000519947, 5216.2436446714255, 4754.144254034307, 4831.6325000750085, 4875.366202393666, 4886.877828054185, 4904.3379143816555, 3526.4533997229446, 3560.252347007054, 3568.2693893461133, 3587.8026708531283, 3598.4602309652714, 5188.455212202815, 5205.479452054764, 5206.245094461357, 5212.192110222922, 5231.346081739783, 4946.455889852042, 5052.0, 5061.240813877947, 5106.463821298858, 5130.58955283569, 4984.601231901367, 5012.398512178562, 5018.770401251717, 5072.873178170576, 5073.930272185275, 4875.902481950412, 4879.39007624047, 4975.477574854733, 4980.228064649985, 5002.799888004439, 4893.116150282096, 5112.258722485144, 5118.513741194581, 5143.81083728091, 5160.896782064263, 5111.361079865017, 5128.871518320005, 5133.974330128325, 5137.434882163034, 5146.716930568705], "value": 3847.8963591990637, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.3641331222186, 635.431288996348, 688.2841844481738, 692.8475735338226, 703.8486725354051, 12441.066919980993, 12978.805317920238, 13273.33633318335, 13337.13308634938, 13370.398332075069, 12457.252564846092, 12537.0, 12825.871741282584, 12844.229346239232, 12899.806502902464, 804.7585724282707, 825.3397282174267, 825.9132791056943, 825.9710910118147, 827.5159031966307, 786.0135529909955, 816.9060558035812, 819.6803246733779, 823.0082750285922, 823.4565186976597, 853.8847255620474, 854.7350321400355, 855.5764896376271, 855.84166929118, 856.6102423397339, 848.3425345357398, 848.3891598049395, 848.5545088828353, 848.7581039403772, 849.8725191221305, 627.1251604012423, 627.2285089340137, 628.4124343738619, 628.8365025093509, 629.0595559638369, 12538.68653283666, 12746.681332966657, 13031.674208144777, 13076.86923130766, 13126.343682815821, 12408.62774116778, 12783.23300601967, 12790.424430900632, 12895.67760805978, 13110.27893465859, 10389.168866490663, 10483.68548943533, 10577.206709496819, 10683.252172347939, 10734.516946737416, 3218.951715724266, 3254.5280934264397, 3262.5432439458496, 3347.6150242722156, 3388.4070287699556, 64113.67943160254, 65470.0, 65582.0, 67148.66425667937, 67305.66347168281, 9571.90428095724, 9606.231501479864, 9750.512474376395, 9845.163161131384, 9893.60425582983, 18029.098545072695, 18035.909820450815, 18221.08894555267, 18257.543561410806, 18272.63454730898, 6301.495880329654, 6481.805545833632, 6648.368405001517, 6705.597664140168, 6867.519273650796, 3591.5331006968927, 3608.711303095746, 3622.005843224967, 3666.7616604920595, 3709.0727318170457, 2793.9580906286424, 2838.148555433403, 2856.114604472579, 2869.9282517937218, 2870.956935645967, 470.1490302552391, 472.8014234021719, 473.091664005111, 476.1310608140158, 477.55587303807096, 561.4503969045464, 566.5326105962597, 572.4104172702123, 589.5018709190726, 592.386879579633, 7189.352958233784, 7591.013168288087, 7731.961340193263, 7858.567778772108, 7969.362451004022, 546.5654804430487, 563.5688698145922, 566.7138095261867, 592.1620906417371, 597.8087012156068, 3582.9283414331567, 3586.7625669144104, 3587.5470434474078, 3612.2414292998237, 3771.2834561433788, 54022.45977540253, 64959.350406496276, 65951.0, 66328.6683566579, 66517.0, 44517.0, 50621.49378506241, 58176.70911645415, 58244.0, 60913.69543152256, 50701.49298506968, 51829.74085129626, 52174.73912630413, 52508.21237681438, 53009.0, 6940.305969403221, 7275.1997280298065, 7278.96360518194, 7300.087489063867, 7301.379382752525, 36453.81773091224, 37285.25429491341, 37314.0, 37948.0, 38330.61669383271, 45362.77318613386, 45495.31757023581, 45599.0, 45824.770876145405, 47693.33073342416, 9662.420254784736, 9883.159931405911, 9917.107460328605, 9940.254480913816, 9963.601455941682, 10548.578056877946, 10733.946330268298, 12221.75556488883, 12265.448054837376, 12452.003839692985, 11593.24643898144, 11743.706407339885, 11852.229605075643, 12264.202826816228, 12822.557873409163, 11894.405279736151, 11958.711354377616, 12109.33398663082, 12187.0, 12385.318807465675, 11545.769084618092, 11856.644300670994, 11911.404429778304, 12207.267563946192, 12808.74382512326, 9842.803143937224, 10048.49757512136, 10223.386596804216, 10262.538185781807, 10435.269531133052, 9107.954460227656, 9638.759031024, 9859.260555458226, 9871.457069860939, 9956.2532810041], "value": 6183.584672848695, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1569.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 118.0, 115.0, 116.0, 115.0, 116.0, 117.0, 116.0, 115.0, 117.0], "value": 115.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 131.0, 128.0, 167.0, 128.0, 128.0, 128.0, 134.0, 153.0, 137.0], "value": 138.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 171.0, 166.0, 176.0, 162.0, 162.0, 163.0, 164.0, 164.0, 168.0], "value": 166.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 76.0, 107.0, 77.0, 76.0, 76.0, 77.0, 101.0, 76.0], "value": 81.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 106.0, 85.0, 85.0, 84.0, 106.0, 84.0, 85.0, 111.0], "value": 91.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 119.0, 118.0, 118.0, 118.0, 123.0, 118.0, 118.0, 118.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 151.0, 149.0, 152.0, 151.0, 151.0, 151.0, 152.0, 151.0], "value": 151.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 97.0, 95.0, 96.0, 96.0, 97.0, 95.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 65.0, 66.0, 66.0, 65.0, 68.0, 68.0, 66.0], "value": 65.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 67.0, 67.0, 67.0, 70.0, 68.0, 68.0, 67.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 86.0, 86.0, 86.0, 84.0, 90.0, 91.0, 84.0, 85.0], "value": 86.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 149.0, 137.0, 137.0, 135.0, 138.0, 135.0, 136.0, 209.0, 136.0], "value": 145.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 175.0, 175.0, 175.0, 176.0, 175.0, 178.0, 176.0, 175.0, 173.0], "value": 175.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 70.0, 73.0, 68.0, 70.0, 68.0, 68.0, 69.0, 73.0, 67.0], "value": 70.1, "unit": "score"}]}]} 07:59:29 INFO - Return code: 0 07:59:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:59:29 ERROR - # TBPL SUCCESS # 07:59:29 INFO - Running post-action listener: _resource_record_post_action 07:59:29 INFO - [mozharness: 2017-01-04 15:59:29.288148Z] Finished run-tests step (success) 07:59:29 INFO - Running post-run listener: _resource_record_post_run 07:59:29 INFO - Total resource usage - Wall time: 1199s; CPU: 13.0%; Read bytes: 4096; Write bytes: 389775360; Read time: 8; Write time: 243584 07:59:29 INFO - TinderboxPrint: CPU usage
13.5% 07:59:29 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 8 07:59:29 INFO - TinderboxPrint: I/O write bytes / time
389,775,360 / 243,584 07:59:29 INFO - TinderboxPrint: CPU idle
8,273.1 (86.5%) 07:59:29 INFO - TinderboxPrint: CPU user
1,235.8 (12.9%) 07:59:29 INFO - TinderboxPrint: Swap in / out
0 / 0 07:59:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 106070016; Read time: 0; Write time: 92632 07:59:29 INFO - run-tests - Wall time: 1184s; CPU: 14.0%; Read bytes: 0; Write bytes: 283705344; Read time: 0; Write time: 150952 07:59:29 INFO - Running post-run listener: _upload_blobber_files 07:59:29 INFO - Blob upload gear active. 07:59:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:59:29 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 07:59:29 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'] 07:59:29 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 07:59:30 INFO - (blobuploader) - INFO - Open directory for files ... 07:59:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:59:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:59:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:59:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:59:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:59:31 INFO - (blobuploader) - INFO - Done attempting. 07:59:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:59:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:59:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:59:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:59:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:59:34 INFO - (blobuploader) - INFO - Done attempting. 07:59:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:59:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:59:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:59:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:59:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:59:35 INFO - (blobuploader) - INFO - Done attempting. 07:59:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:59:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:59:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:59:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:59:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:59:36 INFO - (blobuploader) - INFO - Done attempting. 07:59:36 INFO - (blobuploader) - INFO - Iteration through files over. 07:59:36 INFO - Return code: 0 07:59:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:59:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:59:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/029c36eabfc51d67e2b5ccfda9058038ab55373e91e22908982d664e11152261b391d653d58c85632023cd5f401a011e6bac66394959869cab38a3b0826f3298", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/69fe1432139c7819d61f44543b2270c96505f8651d9a3f7172fee153db96a8946a6b1980b7ef7e2c2ddff6ab63df51eb61b7d290f5cc7a293654ed1b9cb3afc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38f6f8c04034d4ac664577f4c76d01c29df07467c6a7089f52c61e6c14b593e37be9987b0468fa3d203d22233ed603422fe60dd99be6fb78ec91556ce889c265", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ed8099a42e0cde21edb100f54718c9d66704cd5d4f0d3f27a7c59b63427dd9290d08ccbf6f6ffd1ac45a33d7a987d72901b0b381cfd4f28d3b8f70b46249274f"} 07:59:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:59:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:59:36 INFO - Contents: 07:59:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/029c36eabfc51d67e2b5ccfda9058038ab55373e91e22908982d664e11152261b391d653d58c85632023cd5f401a011e6bac66394959869cab38a3b0826f3298", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/69fe1432139c7819d61f44543b2270c96505f8651d9a3f7172fee153db96a8946a6b1980b7ef7e2c2ddff6ab63df51eb61b7d290f5cc7a293654ed1b9cb3afc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38f6f8c04034d4ac664577f4c76d01c29df07467c6a7089f52c61e6c14b593e37be9987b0468fa3d203d22233ed603422fe60dd99be6fb78ec91556ce889c265", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ed8099a42e0cde21edb100f54718c9d66704cd5d4f0d3f27a7c59b63427dd9290d08ccbf6f6ffd1ac45a33d7a987d72901b0b381cfd4f28d3b8f70b46249274f"} 07:59:36 INFO - Running post-run listener: copy_logs_to_upload_dir 07:59:36 INFO - Copying logs to upload dir... 07:59:36 INFO - mkdir: /builds/slave/test/build/upload/logs 07:59:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1248.047277 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 48 secs) (at 2017-01-04 07:59:35.324070) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-04 07:59:35.327920) ========= 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=ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/029c36eabfc51d67e2b5ccfda9058038ab55373e91e22908982d664e11152261b391d653d58c85632023cd5f401a011e6bac66394959869cab38a3b0826f3298", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/69fe1432139c7819d61f44543b2270c96505f8651d9a3f7172fee153db96a8946a6b1980b7ef7e2c2ddff6ab63df51eb61b7d290f5cc7a293654ed1b9cb3afc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38f6f8c04034d4ac664577f4c76d01c29df07467c6a7089f52c61e6c14b593e37be9987b0468fa3d203d22233ed603422fe60dd99be6fb78ec91556ce889c265", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ed8099a42e0cde21edb100f54718c9d66704cd5d4f0d3f27a7c59b63427dd9290d08ccbf6f6ffd1ac45a33d7a987d72901b0b381cfd4f28d3b8f70b46249274f"} build_url:https://queue.taskcluster.net/v1/task/MLNBNqopQE2dS_AxiBPXDA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011214 build_url: 'https://queue.taskcluster.net/v1/task/MLNBNqopQE2dS_AxiBPXDA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/029c36eabfc51d67e2b5ccfda9058038ab55373e91e22908982d664e11152261b391d653d58c85632023cd5f401a011e6bac66394959869cab38a3b0826f3298", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/69fe1432139c7819d61f44543b2270c96505f8651d9a3f7172fee153db96a8946a6b1980b7ef7e2c2ddff6ab63df51eb61b7d290f5cc7a293654ed1b9cb3afc8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/38f6f8c04034d4ac664577f4c76d01c29df07467c6a7089f52c61e6c14b593e37be9987b0468fa3d203d22233ed603422fe60dd99be6fb78ec91556ce889c265", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ed8099a42e0cde21edb100f54718c9d66704cd5d4f0d3f27a7c59b63427dd9290d08ccbf6f6ffd1ac45a33d7a987d72901b0b381cfd4f28d3b8f70b46249274f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-04 07:59:35.353134) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 07:59:35.353456) ========= 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=ed14279e38b05397cf4aa391000001a4-1483544326.18767-780320745 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 07:59:35.435499) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-04 07:59:35.435802) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-04 07:59:35.436096) ========= ========= Total master_lag: 0.17 =========