builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-030 starttime: 1483802111.31 results: success (0) revision: 178a3ce2f4fc9246da98af2d0c6519884ec677fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-07 07:15:11.309271) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-07 07:15:11.309732) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-07 07:15:11.310018) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-07 07:15:11.326983) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 07:15:11.327293) ========= 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=3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-01-07 07:15:11-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 42.1M=0s 2017-01-07 07:15:11 (42.1 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.077712 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 07:15:11.419406) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 07:15:11.419748) ========= 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=3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020668 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 07:15:11.469328) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 07:15:11.469676) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 178a3ce2f4fc9246da98af2d0c6519884ec677fa --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 178a3ce2f4fc9246da98af2d0c6519884ec677fa --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=3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-01-07 07:15:11,909 truncating revision to first 12 chars 2017-01-07 07:15:11,909 Setting DEBUG logging. 2017-01-07 07:15:11,910 attempt 1/10 2017-01-07 07:15:11,910 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/178a3ce2f4fc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-07 07:15:12,261 unpacking tar archive at: mozilla-central-178a3ce2f4fc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.730588 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 07:15:12.213601) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-07 07:15:12.213906) ========= script_repo_revision: 178a3ce2f4fc9246da98af2d0c6519884ec677fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-07 07:15:12.214274) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-07 07:15:12.214575) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-07 07:15:12.224031) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-01-07 07:15:12.224382) ========= /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=3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:15:12 INFO - MultiFileLogger online at 20170107 07:15:12 in /builds/slave/test 07:15:12 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:15:12 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:15:12 INFO - {'append_to_log': False, 07:15:12 INFO - 'base_work_dir': '/builds/slave/test', 07:15:12 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:15:12 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:15:12 INFO - 'branch': 'Firefox-Non-PGO', 07:15:12 INFO - 'buildbot_json_path': 'buildprops.json', 07:15:12 INFO - 'config_files': ('talos/linux_config.py',), 07:15:12 INFO - 'default_actions': ('clobber', 07:15:12 INFO - 'read-buildbot-config', 07:15:12 INFO - 'download-and-extract', 07:15:12 INFO - 'populate-webroot', 07:15:12 INFO - 'create-virtualenv', 07:15:12 INFO - 'install', 07:15:12 INFO - 'run-tests'), 07:15:12 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:15:12 INFO - 'download_minidump_stackwalk': True, 07:15:12 INFO - 'download_symbols': 'ondemand', 07:15:12 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:15:12 INFO - 'tooltool.py': '/tools/tooltool.py', 07:15:12 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:15:12 INFO - '/tools/misc-python/virtualenv.py')}, 07:15:12 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:15:12 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:15:12 INFO - 'installer_path': 'installer.exe', 07:15:12 INFO - 'log_level': 'info', 07:15:12 INFO - 'log_name': 'talos', 07:15:12 INFO - 'log_to_console': True, 07:15:12 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:15:12 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:15:12 INFO - 'opt_config_files': (), 07:15:12 INFO - 'pip_index': False, 07:15:12 INFO - 'sps_profile': False, 07:15:12 INFO - 'sps_profile_interval': 0, 07:15:12 INFO - 'suite': 'dromaeojs-e10s', 07:15:12 INFO - 'system_bits': '32', 07:15:12 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:15:12 INFO - 'title': 'talos-linux64-ix-030', 07:15:12 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:15:12 INFO - 'use_talos_json': True, 07:15:12 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:15:12 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:15:12 INFO - 'work_dir': 'build'} 07:15:12 INFO - [mozharness: 2017-01-07 15:15:12.761737Z] Running clobber step. 07:15:12 INFO - Running pre-action listener: _resource_record_pre_action 07:15:12 INFO - Running main action method: clobber 07:15:12 INFO - rmtree: /builds/slave/test/build 07:15:12 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:15:13 INFO - Running post-action listener: _resource_record_post_action 07:15:13 INFO - [mozharness: 2017-01-07 15:15:13.740901Z] Finished clobber step (success) 07:15:13 INFO - [mozharness: 2017-01-07 15:15:13.740999Z] Running read-buildbot-config step. 07:15:13 INFO - Running pre-action listener: _resource_record_pre_action 07:15:13 INFO - Running main action method: read_buildbot_config 07:15:13 INFO - Using buildbot properties: 07:15:13 INFO - { 07:15:13 INFO - "project": "", 07:15:13 INFO - "product": "firefox", 07:15:13 INFO - "who": "ffxbld@noreply.mozilla.org", 07:15:13 INFO - "installer_path": "public/build/target.tar.bz2", 07:15:13 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 07:15:13 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 07:15:13 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 07:15:13 INFO - "stage_platform": "linux64", 07:15:13 INFO - "basedir": "/builds/slave/test", 07:15:13 INFO - "buildnumber": 629, 07:15:13 INFO - "platform": "ubuntu64_hw", 07:15:13 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:15:13 INFO - "slavebuilddir": "test", 07:15:13 INFO - "taskId": "VyM6SYBvQvWfZ4JPIhEVOQ", 07:15:13 INFO - "branch": "mozilla-central", 07:15:13 INFO - "script_repo_revision": "production", 07:15:13 INFO - "revision": "178a3ce2f4fc9246da98af2d0c6519884ec677fa", 07:15:13 INFO - "slavename": "talos-linux64-ix-030", 07:15:13 INFO - "repo_path": "mozilla-central" 07:15:13 INFO - } 07:15:13 INFO - Finding installer, test and symbols from parent task. 07:15:13 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VyM6SYBvQvWfZ4JPIhEVOQ'}, attempt #1 07:15:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/VyM6SYBvQvWfZ4JPIhEVOQ'}, attempt #1 07:15:14 INFO - Task dependencies: btn9mzhtRzujZVq9U-TocA 07:15:14 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/btn9mzhtRzujZVq9U-TocA'}, attempt #1 07:15:15 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/btn9mzhtRzujZVq9U-TocA/artifacts/public/build/target.tar.bz2 07:15:15 INFO - Set test_url: https://queue.taskcluster.net/v1/task/btn9mzhtRzujZVq9U-TocA/artifacts/public/build/test_packages.json 07:15:15 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/btn9mzhtRzujZVq9U-TocA/artifacts/public/build/target.crashreporter-symbols.zip 07:15:15 INFO - Running post-action listener: _resource_record_post_action 07:15:15 INFO - [mozharness: 2017-01-07 15:15:15.212618Z] Finished read-buildbot-config step (success) 07:15:15 INFO - [mozharness: 2017-01-07 15:15:15.212836Z] Running download-and-extract step. 07:15:15 INFO - Running pre-action listener: _resource_record_pre_action 07:15:15 INFO - Running main action method: download_and_extract 07:15:15 INFO - mkdir: /builds/slave/test/build/tests 07:15:15 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:15:15 INFO - trying https://queue.taskcluster.net/v1/task/btn9mzhtRzujZVq9U-TocA/artifacts/public/build/target.test_packages.json 07:15:15 INFO - Downloading https://queue.taskcluster.net/v1/task/btn9mzhtRzujZVq9U-TocA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 07:15:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/btn9mzhtRzujZVq9U-TocA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 07:15:15 INFO - Downloaded 896 bytes. 07:15:15 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 07:15:15 INFO - Using the following test package requirements: 07:15:15 INFO - {u'common': [u'target.common.tests.zip'], 07:15:15 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 07:15:15 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 07:15:15 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 07:15:15 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 07:15:15 INFO - u'mozbase': [u'target.common.tests.zip'], 07:15:15 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 07:15:15 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 07:15:15 INFO - u'web-platform': [u'target.common.tests.zip', 07:15:15 INFO - u'target.web-platform.tests.zip'], 07:15:15 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 07:15:15 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 07:15:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/btn9mzhtRzujZVq9U-TocA/artifacts/public/build/target.common.tests.zip 07:15:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/btn9mzhtRzujZVq9U-TocA/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:15:15 INFO - Fetch https://queue.taskcluster.net/v1/task/btn9mzhtRzujZVq9U-TocA/artifacts/public/build/target.common.tests.zip into memory 07:15:16 INFO - Expected file size: 20246889 07:15:16 INFO - Obtained file size: 20246889 07:15:20 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 07:15:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/btn9mzhtRzujZVq9U-TocA/artifacts/public/build/target.common.tests.zip 07:15:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/btn9mzhtRzujZVq9U-TocA/artifacts/public/build/target.common.tests.zip'}, attempt #1 07:15:20 INFO - Fetch https://queue.taskcluster.net/v1/task/btn9mzhtRzujZVq9U-TocA/artifacts/public/build/target.common.tests.zip into memory 07:15:21 INFO - Expected file size: 20246889 07:15:21 INFO - Obtained file size: 20246889 07:15:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/btn9mzhtRzujZVq9U-TocA/artifacts/public/build/target.talos.tests.zip 07:15:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/btn9mzhtRzujZVq9U-TocA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 07:15:25 INFO - Fetch https://queue.taskcluster.net/v1/task/btn9mzhtRzujZVq9U-TocA/artifacts/public/build/target.talos.tests.zip into memory 07:15:26 INFO - Expected file size: 14403730 07:15:26 INFO - Obtained file size: 14403730 07:15:26 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:15:26 INFO - trying https://queue.taskcluster.net/v1/task/btn9mzhtRzujZVq9U-TocA/artifacts/public/build/target.tar.bz2 07:15:26 INFO - Downloading https://queue.taskcluster.net/v1/task/btn9mzhtRzujZVq9U-TocA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 07:15:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/btn9mzhtRzujZVq9U-TocA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 07:15:28 INFO - Downloaded 55879389 bytes. 07:15:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/btn9mzhtRzujZVq9U-TocA/artifacts/public/build/target.tar.bz2 07:15:28 INFO - mkdir: /builds/slave/test/properties 07:15:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:15:28 INFO - Writing to file /builds/slave/test/properties/build_url 07:15:28 INFO - Contents: 07:15:28 INFO - build_url:https://queue.taskcluster.net/v1/task/btn9mzhtRzujZVq9U-TocA/artifacts/public/build/target.tar.bz2 07:15:28 INFO - Running post-action listener: _resource_record_post_action 07:15:28 INFO - Running post-action listener: set_extra_try_arguments 07:15:28 INFO - [mozharness: 2017-01-07 15:15:28.548134Z] Finished download-and-extract step (success) 07:15:28 INFO - [mozharness: 2017-01-07 15:15:28.548231Z] Running populate-webroot step. 07:15:28 INFO - Running pre-action listener: _resource_record_pre_action 07:15:28 INFO - Running main action method: populate_webroot 07:15:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:15:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:15:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:15:28 INFO - '--tppagecycles', 07:15:28 INFO - '7'], 07:15:28 INFO - 'tests': ['tsvgm']}}, 07:15:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:15:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:15:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:15:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:15:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:15:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:15:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:15:28 INFO - 'talos_options': ['--disable-e10s'], 07:15:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:15:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:15:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:15:28 INFO - 'talos_options': ['--disable-e10s'], 07:15:28 INFO - 'tests': ['damp', 'tps']}, 07:15:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:15:28 INFO - 'tests': ['damp', 'tps']}, 07:15:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:15:28 INFO - 'tests': ['dromaeo_dom']}, 07:15:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:15:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:15:28 INFO - 'tests': ['basic_compositor_video']}, 07:15:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:15:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:15:28 INFO - 'tests': ['a11yr', 07:15:28 INFO - 'ts_paint', 07:15:28 INFO - 'tpaint', 07:15:28 INFO - 'sessionrestore', 07:15:28 INFO - 'sessionrestore_no_auto_restore', 07:15:28 INFO - 'tabpaint']}, 07:15:28 INFO - 'other-e10s': {'tests': ['a11yr', 07:15:28 INFO - 'ts_paint', 07:15:28 INFO - 'tpaint', 07:15:28 INFO - 'sessionrestore', 07:15:28 INFO - 'sessionrestore_no_auto_restore', 07:15:28 INFO - 'tabpaint']}, 07:15:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:15:28 INFO - 'ts_paint', 07:15:28 INFO - 'tpaint', 07:15:28 INFO - 'sessionrestore', 07:15:28 INFO - 'sessionrestore_no_auto_restore', 07:15:28 INFO - 'tabpaint']}, 07:15:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:15:28 INFO - 'ts_paint', 07:15:28 INFO - 'tpaint', 07:15:28 INFO - 'sessionrestore', 07:15:28 INFO - 'sessionrestore_no_auto_restore', 07:15:28 INFO - 'tabpaint']}, 07:15:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:15:28 INFO - 'tests': ['a11yr', 07:15:28 INFO - 'ts_paint', 07:15:28 INFO - 'tpaint', 07:15:28 INFO - 'sessionrestore', 07:15:28 INFO - 'sessionrestore_no_auto_restore', 07:15:28 INFO - 'tabpaint']}, 07:15:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:15:28 INFO - 'tests': ['a11yr', 07:15:28 INFO - 'ts_paint', 07:15:28 INFO - 'tpaint', 07:15:28 INFO - 'sessionrestore', 07:15:28 INFO - 'sessionrestore_no_auto_restore', 07:15:28 INFO - 'tabpaint']}, 07:15:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:15:28 INFO - 'tests': ['tsvgx', 07:15:28 INFO - 'tsvgr_opacity', 07:15:28 INFO - 'tart', 07:15:28 INFO - 'tscrollx', 07:15:28 INFO - 'cart', 07:15:28 INFO - 'tsvg_static']}, 07:15:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:15:28 INFO - 'tsvgr_opacity', 07:15:28 INFO - 'tart', 07:15:28 INFO - 'tscrollx', 07:15:28 INFO - 'cart', 07:15:28 INFO - 'tsvg_static']}, 07:15:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:15:28 INFO - 'talos_options': ['--disable-e10s'], 07:15:28 INFO - 'tests': ['tp5o']}, 07:15:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:15:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:15:28 INFO - 'talos_options': ['--disable-e10s', 07:15:28 INFO - '--xperf_path', 07:15:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:28 INFO - 'tests': ['tp5n']}, 07:15:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:15:28 INFO - 'talos_options': ['--xperf_path', 07:15:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:15:28 INFO - 'tests': ['tp5n']}}, 07:15:28 INFO - 'talos.zip': {'path': '', 07:15:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:15:28 INFO - Running post-action listener: _resource_record_post_action 07:15:28 INFO - [mozharness: 2017-01-07 15:15:28.561369Z] Finished populate-webroot step (success) 07:15:28 INFO - [mozharness: 2017-01-07 15:15:28.561459Z] Running create-virtualenv step. 07:15:28 INFO - Running pre-action listener: _resource_record_pre_action 07:15:28 INFO - Running main action method: create_virtualenv 07:15:28 INFO - Creating virtualenv /builds/slave/test/build/venv 07:15:28 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:15:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:15:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:15:28 INFO - Using real prefix '/usr' 07:15:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:15:29 INFO - Installing distribute.............................................................................................................................................................................................done. 07:15:31 INFO - Installing pip.................done. 07:15:31 INFO - Return code: 0 07:15:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:15:31 INFO - Reading from file tmpfile_stdout 07:15:31 INFO - Output received: 07:15:31 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:15:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2652820>, '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 0x2653520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26539b0>, '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': '3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964', '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:15:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:15:31 INFO - Using env: {'DISPLAY': ':0', 07:15:31 INFO - 'HOME': '/home/cltbld', 07:15:31 INFO - 'LANG': 'en_US.UTF-8', 07:15:31 INFO - 'LANGUAGE': 'en_US:en', 07:15:31 INFO - 'LOGNAME': 'cltbld', 07:15:31 INFO - 'MAIL': '/var/mail/cltbld', 07:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:31 INFO - 'MOZ_NO_REMOTE': '1', 07:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:31 INFO - 'NO_EM_RESTART': '1', 07:15:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:31 INFO - 'PWD': '/builds/slave/test', 07:15:31 INFO - 'SHELL': '/bin/bash', 07:15:31 INFO - 'SHLVL': '1', 07:15:31 INFO - 'TERM': 'linux', 07:15:31 INFO - 'TMOUT': '86400', 07:15:31 INFO - 'USER': 'cltbld', 07:15:31 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964', 07:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:31 INFO - '_': '/tools/buildbot/bin/python'} 07:15:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:31 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:15:31 INFO - Cleaning up... 07:15:31 INFO - Return code: 0 07:15:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2652820>, '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 0x2653520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26539b0>, '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': '3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964', '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:15:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:15:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:15:31 INFO - Using env: {'DISPLAY': ':0', 07:15:31 INFO - 'HOME': '/home/cltbld', 07:15:31 INFO - 'LANG': 'en_US.UTF-8', 07:15:31 INFO - 'LANGUAGE': 'en_US:en', 07:15:31 INFO - 'LOGNAME': 'cltbld', 07:15:31 INFO - 'MAIL': '/var/mail/cltbld', 07:15:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:31 INFO - 'MOZ_NO_REMOTE': '1', 07:15:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:31 INFO - 'NO_EM_RESTART': '1', 07:15:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:31 INFO - 'PWD': '/builds/slave/test', 07:15:31 INFO - 'SHELL': '/bin/bash', 07:15:31 INFO - 'SHLVL': '1', 07:15:31 INFO - 'TERM': 'linux', 07:15:31 INFO - 'TMOUT': '86400', 07:15:31 INFO - 'USER': 'cltbld', 07:15:31 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964', 07:15:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:31 INFO - '_': '/tools/buildbot/bin/python'} 07:15:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:31 INFO - Downloading/unpacking psutil>=3.1.1 07:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:15:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:33 INFO - Installing collected packages: psutil 07:15:33 INFO - Running setup.py install for psutil 07:15:33 INFO - building 'psutil._psutil_linux' extension 07:15:33 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:15:34 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:15:34 INFO - building 'psutil._psutil_posix' extension 07:15:34 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:15:34 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:15:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:15:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:15:34 INFO - Successfully installed psutil 07:15:34 INFO - Cleaning up... 07:15:34 INFO - Return code: 0 07:15:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2652820>, '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 0x2653520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26539b0>, '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': '3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964', '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:15:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:15:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:15:34 INFO - Using env: {'DISPLAY': ':0', 07:15:34 INFO - 'HOME': '/home/cltbld', 07:15:34 INFO - 'LANG': 'en_US.UTF-8', 07:15:34 INFO - 'LANGUAGE': 'en_US:en', 07:15:34 INFO - 'LOGNAME': 'cltbld', 07:15:34 INFO - 'MAIL': '/var/mail/cltbld', 07:15:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:34 INFO - 'MOZ_NO_REMOTE': '1', 07:15:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:34 INFO - 'NO_EM_RESTART': '1', 07:15:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:34 INFO - 'PWD': '/builds/slave/test', 07:15:34 INFO - 'SHELL': '/bin/bash', 07:15:34 INFO - 'SHLVL': '1', 07:15:34 INFO - 'TERM': 'linux', 07:15:34 INFO - 'TMOUT': '86400', 07:15:34 INFO - 'USER': 'cltbld', 07:15:34 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964', 07:15:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:34 INFO - '_': '/tools/buildbot/bin/python'} 07:15:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:15:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:15:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:15:36 INFO - Installing collected packages: mozsystemmonitor 07:15:36 INFO - Running setup.py install for mozsystemmonitor 07:15:36 INFO - Successfully installed mozsystemmonitor 07:15:36 INFO - Cleaning up... 07:15:36 INFO - Return code: 0 07:15:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2652820>, '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 0x2653520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26539b0>, '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': '3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964', '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:15:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:15:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:15:36 INFO - Using env: {'DISPLAY': ':0', 07:15:36 INFO - 'HOME': '/home/cltbld', 07:15:36 INFO - 'LANG': 'en_US.UTF-8', 07:15:36 INFO - 'LANGUAGE': 'en_US:en', 07:15:36 INFO - 'LOGNAME': 'cltbld', 07:15:36 INFO - 'MAIL': '/var/mail/cltbld', 07:15:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:36 INFO - 'MOZ_NO_REMOTE': '1', 07:15:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:36 INFO - 'NO_EM_RESTART': '1', 07:15:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:36 INFO - 'PWD': '/builds/slave/test', 07:15:36 INFO - 'SHELL': '/bin/bash', 07:15:36 INFO - 'SHLVL': '1', 07:15:36 INFO - 'TERM': 'linux', 07:15:36 INFO - 'TMOUT': '86400', 07:15:36 INFO - 'USER': 'cltbld', 07:15:36 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964', 07:15:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:36 INFO - '_': '/tools/buildbot/bin/python'} 07:15:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:37 INFO - Downloading/unpacking jsonschema==2.5.1 07:15:37 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:15:37 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:15:37 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:15:37 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:15:37 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:15:37 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:15:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:15:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:39 INFO - Downloading functools32-3.2.3-2.tar.gz 07:15:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:15:39 INFO - warning: no files found matching '*.txt' 07:15:39 INFO - no previously-included directories found matching 'build' 07:15:39 INFO - no previously-included directories found matching 'dist' 07:15:39 INFO - no previously-included directories found matching '.git*' 07:15:39 INFO - Installing collected packages: jsonschema, functools32 07:15:39 INFO - Running setup.py install for functools32 07:15:39 INFO - warning: no files found matching '*.txt' 07:15:39 INFO - no previously-included directories found matching 'build' 07:15:39 INFO - no previously-included directories found matching 'dist' 07:15:39 INFO - no previously-included directories found matching '.git*' 07:15:39 INFO - Successfully installed jsonschema functools32 07:15:39 INFO - Cleaning up... 07:15:39 INFO - Return code: 0 07:15:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2652820>, '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 0x2653520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26539b0>, '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': '3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964', '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:15:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:15:39 INFO - Using env: {'DISPLAY': ':0', 07:15:39 INFO - 'HOME': '/home/cltbld', 07:15:39 INFO - 'LANG': 'en_US.UTF-8', 07:15:39 INFO - 'LANGUAGE': 'en_US:en', 07:15:39 INFO - 'LOGNAME': 'cltbld', 07:15:39 INFO - 'MAIL': '/var/mail/cltbld', 07:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:39 INFO - 'MOZ_NO_REMOTE': '1', 07:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:39 INFO - 'NO_EM_RESTART': '1', 07:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:39 INFO - 'PWD': '/builds/slave/test', 07:15:39 INFO - 'SHELL': '/bin/bash', 07:15:39 INFO - 'SHLVL': '1', 07:15:39 INFO - 'TERM': 'linux', 07:15:39 INFO - 'TMOUT': '86400', 07:15:39 INFO - 'USER': 'cltbld', 07:15:39 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964', 07:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:39 INFO - '_': '/tools/buildbot/bin/python'} 07:15:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:15:39 INFO - Cleaning up... 07:15:39 INFO - Return code: 0 07:15:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2652820>, '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 0x2653520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26539b0>, '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': '3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964', '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:15:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:15:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:15:39 INFO - Using env: {'DISPLAY': ':0', 07:15:39 INFO - 'HOME': '/home/cltbld', 07:15:39 INFO - 'LANG': 'en_US.UTF-8', 07:15:39 INFO - 'LANGUAGE': 'en_US:en', 07:15:39 INFO - 'LOGNAME': 'cltbld', 07:15:39 INFO - 'MAIL': '/var/mail/cltbld', 07:15:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:39 INFO - 'MOZ_NO_REMOTE': '1', 07:15:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:39 INFO - 'NO_EM_RESTART': '1', 07:15:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:39 INFO - 'PWD': '/builds/slave/test', 07:15:39 INFO - 'SHELL': '/bin/bash', 07:15:39 INFO - 'SHLVL': '1', 07:15:39 INFO - 'TERM': 'linux', 07:15:39 INFO - 'TMOUT': '86400', 07:15:39 INFO - 'USER': 'cltbld', 07:15:39 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964', 07:15:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:39 INFO - '_': '/tools/buildbot/bin/python'} 07:15:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:40 INFO - Downloading/unpacking blobuploader==1.2.4 07:15:40 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:15:40 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:15:40 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:15:40 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:15:40 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:15:40 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:15:42 INFO - Downloading blobuploader-1.2.4.tar.gz 07:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:15:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:15:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:15:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:15:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:15:42 INFO - Downloading docopt-0.6.1.tar.gz 07:15:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:15:42 INFO - Installing collected packages: blobuploader, requests, docopt 07:15:42 INFO - Running setup.py install for blobuploader 07:15:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:15:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:15:42 INFO - Running setup.py install for requests 07:15:43 INFO - Running setup.py install for docopt 07:15:43 INFO - Successfully installed blobuploader requests docopt 07:15:43 INFO - Cleaning up... 07:15:43 INFO - Return code: 0 07:15:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:43 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:15:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:43 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:15:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:43 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 0x22e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2652820>, '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 0x2653520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26539b0>, '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': '3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964', '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:15:43 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:15:43 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:15:43 INFO - Using env: {'DISPLAY': ':0', 07:15:43 INFO - 'HOME': '/home/cltbld', 07:15:43 INFO - 'LANG': 'en_US.UTF-8', 07:15:43 INFO - 'LANGUAGE': 'en_US:en', 07:15:43 INFO - 'LOGNAME': 'cltbld', 07:15:43 INFO - 'MAIL': '/var/mail/cltbld', 07:15:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:43 INFO - 'MOZ_NO_REMOTE': '1', 07:15:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:43 INFO - 'NO_EM_RESTART': '1', 07:15:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:43 INFO - 'PWD': '/builds/slave/test', 07:15:43 INFO - 'SHELL': '/bin/bash', 07:15:43 INFO - 'SHLVL': '1', 07:15:43 INFO - 'TERM': 'linux', 07:15:43 INFO - 'TMOUT': '86400', 07:15:43 INFO - 'USER': 'cltbld', 07:15:43 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964', 07:15:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:43 INFO - '_': '/tools/buildbot/bin/python'} 07:15:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:43 INFO - Running setup.py (path:/tmp/pip-zlsXqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:43 INFO - Running setup.py (path:/tmp/pip-dPEbmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:43 INFO - Running setup.py (path:/tmp/pip-WVu_Hv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:43 INFO - Running setup.py (path:/tmp/pip-4rYQ0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:43 INFO - Running setup.py (path:/tmp/pip-u2JHvR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:44 INFO - Running setup.py (path:/tmp/pip-qIeA3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:44 INFO - Running setup.py (path:/tmp/pip-7tLCVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:44 INFO - Running setup.py (path:/tmp/pip-S1662X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:44 INFO - Running setup.py (path:/tmp/pip-qqDAIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:44 INFO - Running setup.py (path:/tmp/pip-lx2HDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:44 INFO - Running setup.py (path:/tmp/pip-gyzqAP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:44 INFO - Running setup.py (path:/tmp/pip-LfKwwY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:44 INFO - Running setup.py (path:/tmp/pip-ugFCtr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:44 INFO - Running setup.py (path:/tmp/pip-jEvWWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:44 INFO - Running setup.py (path:/tmp/pip-651eJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:44 INFO - Running setup.py (path:/tmp/pip-fYSE7N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:44 INFO - Running setup.py (path:/tmp/pip-_jRCzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:15:44 INFO - Running setup.py install for manifestparser 07:15:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:15:44 INFO - Running setup.py install for mozcrash 07:15:45 INFO - Running setup.py install for mozdebug 07:15:45 INFO - Running setup.py install for mozdevice 07:15:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Running setup.py install for mozfile 07:15:45 INFO - Running setup.py install for mozhttpd 07:15:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Running setup.py install for mozinfo 07:15:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Running setup.py install for mozInstall 07:15:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Running setup.py install for mozleak 07:15:45 INFO - Running setup.py install for mozlog 07:15:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:15:45 INFO - Running setup.py install for moznetwork 07:15:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:15:46 INFO - Running setup.py install for mozprocess 07:15:46 INFO - Running setup.py install for mozprofile 07:15:46 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:15:46 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:15:46 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:15:46 INFO - Running setup.py install for mozrunner 07:15:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:15:46 INFO - Running setup.py install for mozscreenshot 07:15:46 INFO - Running setup.py install for moztest 07:15:46 INFO - Running setup.py install for mozversion 07:15:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:15:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:15:46 INFO - Cleaning up... 07:15:46 INFO - Return code: 0 07:15:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:15:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:46 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 0x22e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2652820>, '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 0x2653520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26539b0>, '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': '3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964', '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:15:46 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:15:46 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:15:46 INFO - Using env: {'DISPLAY': ':0', 07:15:46 INFO - 'HOME': '/home/cltbld', 07:15:46 INFO - 'LANG': 'en_US.UTF-8', 07:15:46 INFO - 'LANGUAGE': 'en_US:en', 07:15:46 INFO - 'LOGNAME': 'cltbld', 07:15:46 INFO - 'MAIL': '/var/mail/cltbld', 07:15:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:46 INFO - 'MOZ_NO_REMOTE': '1', 07:15:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:46 INFO - 'NO_EM_RESTART': '1', 07:15:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:46 INFO - 'PWD': '/builds/slave/test', 07:15:46 INFO - 'SHELL': '/bin/bash', 07:15:46 INFO - 'SHLVL': '1', 07:15:46 INFO - 'TERM': 'linux', 07:15:46 INFO - 'TMOUT': '86400', 07:15:46 INFO - 'USER': 'cltbld', 07:15:46 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964', 07:15:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:46 INFO - '_': '/tools/buildbot/bin/python'} 07:15:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:15:46 INFO - Running setup.py (path:/tmp/pip-UQBZYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:15:46 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:15:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:15:46 INFO - Running setup.py (path:/tmp/pip-bNGRp3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:15:47 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:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:15:47 INFO - Running setup.py (path:/tmp/pip-h3uVxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:15:47 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:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:15:47 INFO - Running setup.py (path:/tmp/pip-0lal1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:15:47 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:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:15:47 INFO - Running setup.py (path:/tmp/pip-C6uY6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:15:47 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:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:15:47 INFO - Running setup.py (path:/tmp/pip-AnhDJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:15:47 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:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:15:47 INFO - Running setup.py (path:/tmp/pip-YsV1Rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:15:47 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:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:15:47 INFO - Running setup.py (path:/tmp/pip-c5Mmfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:15:47 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:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:15:47 INFO - Running setup.py (path:/tmp/pip-srAV2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:15:47 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:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:15:47 INFO - Running setup.py (path:/tmp/pip-ADoZZo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:15:47 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:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:15:47 INFO - Running setup.py (path:/tmp/pip-culBRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:15:47 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:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:15:47 INFO - Running setup.py (path:/tmp/pip-ufep00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:15:47 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:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:15:47 INFO - Running setup.py (path:/tmp/pip-ipgsMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:15:47 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:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:15:47 INFO - Running setup.py (path:/tmp/pip-fRvTrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:15:47 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:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:47 INFO - Running setup.py (path:/tmp/pip-1BmqWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:15:47 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:15:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:15:47 INFO - Running setup.py (path:/tmp/pip-ccspZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:15:48 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:15:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:15:48 INFO - Running setup.py (path:/tmp/pip-BtJ0ED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:15:48 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:15:48 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:15:48 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:15:48 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:15:48 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:15:48 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:15:48 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:15:48 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:15:48 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:15:48 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:15:48 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:15:48 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:15:48 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:15:50 INFO - Downloading blessings-1.6.tar.gz 07:15:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:15:50 INFO - Installing collected packages: blessings 07:15:50 INFO - Running setup.py install for blessings 07:15:50 INFO - Successfully installed blessings 07:15:50 INFO - Cleaning up... 07:15:50 INFO - Return code: 0 07:15:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:15:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:15:50 INFO - Reading from file tmpfile_stdout 07:15:50 INFO - Current package versions: 07:15:50 INFO - argparse == 1.2.1 07:15:50 INFO - blessings == 1.6 07:15:50 INFO - blobuploader == 1.2.4 07:15:50 INFO - docopt == 0.6.1 07:15:50 INFO - functools32 == 3.2.3-2 07:15:50 INFO - jsonschema == 2.5.1 07:15:50 INFO - manifestparser == 1.1 07:15:50 INFO - mozInstall == 1.12 07:15:50 INFO - mozcrash == 1.0 07:15:50 INFO - mozdebug == 0.1 07:15:50 INFO - mozdevice == 0.49 07:15:50 INFO - mozfile == 1.2 07:15:50 INFO - mozhttpd == 0.7 07:15:50 INFO - mozinfo == 0.9 07:15:50 INFO - mozleak == 0.1 07:15:50 INFO - mozlog == 3.4 07:15:50 INFO - moznetwork == 0.27 07:15:50 INFO - mozprocess == 0.23 07:15:50 INFO - mozprofile == 0.28 07:15:50 INFO - mozrunner == 6.13 07:15:50 INFO - mozscreenshot == 0.1 07:15:50 INFO - mozsystemmonitor == 0.3 07:15:50 INFO - moztest == 0.8 07:15:50 INFO - mozversion == 1.4 07:15:50 INFO - psutil == 3.1.1 07:15:50 INFO - requests == 1.2.3 07:15:50 INFO - wsgiref == 0.1.2 07:15:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:15: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:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:50 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 0x22e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2652820>, '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 0x2653520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26539b0>, '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': '3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964', '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:15:50 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:15:50 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:15:50 INFO - Using env: {'DISPLAY': ':0', 07:15:50 INFO - 'HOME': '/home/cltbld', 07:15:50 INFO - 'LANG': 'en_US.UTF-8', 07:15:50 INFO - 'LANGUAGE': 'en_US:en', 07:15:50 INFO - 'LOGNAME': 'cltbld', 07:15:50 INFO - 'MAIL': '/var/mail/cltbld', 07:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:50 INFO - 'MOZ_NO_REMOTE': '1', 07:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:50 INFO - 'NO_EM_RESTART': '1', 07:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:50 INFO - 'PWD': '/builds/slave/test', 07:15:50 INFO - 'SHELL': '/bin/bash', 07:15:50 INFO - 'SHLVL': '1', 07:15:50 INFO - 'TERM': 'linux', 07:15:50 INFO - 'TMOUT': '86400', 07:15:50 INFO - 'USER': 'cltbld', 07:15:50 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964', 07:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:50 INFO - '_': '/tools/buildbot/bin/python'} 07:15:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:50 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:15:50 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:15:50 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:15:50 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:15:50 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:15:50 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:15:50 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:15:50 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:15:50 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:15:50 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:15:50 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:15:50 INFO - Cleaning up... 07:15:50 INFO - Return code: 0 07:15:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:15: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:15:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:15:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15: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:15:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:15:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:15:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22e31f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23f4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2655480>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2652820>, '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 0x2653520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26539b0>, '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': '3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964', '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:15:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:15:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:15:50 INFO - Using env: {'DISPLAY': ':0', 07:15:50 INFO - 'HOME': '/home/cltbld', 07:15:50 INFO - 'LANG': 'en_US.UTF-8', 07:15:50 INFO - 'LANGUAGE': 'en_US:en', 07:15:50 INFO - 'LOGNAME': 'cltbld', 07:15:50 INFO - 'MAIL': '/var/mail/cltbld', 07:15:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:15:50 INFO - 'MOZ_NO_REMOTE': '1', 07:15:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:15:50 INFO - 'NO_EM_RESTART': '1', 07:15:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:15:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:15:50 INFO - 'PWD': '/builds/slave/test', 07:15:50 INFO - 'SHELL': '/bin/bash', 07:15:50 INFO - 'SHLVL': '1', 07:15:50 INFO - 'TERM': 'linux', 07:15:50 INFO - 'TMOUT': '86400', 07:15:50 INFO - 'USER': 'cltbld', 07:15:50 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964', 07:15:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:15:50 INFO - '_': '/tools/buildbot/bin/python'} 07:15:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:15:51 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:15:51 INFO - Cleaning up... 07:15:51 INFO - Return code: 0 07:15:51 INFO - Running post-action listener: _resource_record_post_action 07:15:51 INFO - Running post-action listener: _start_resource_monitoring 07:15:51 INFO - Starting resource monitoring. 07:15:51 INFO - [mozharness: 2017-01-07 15:15:51.095535Z] Finished create-virtualenv step (success) 07:15:51 INFO - [mozharness: 2017-01-07 15:15:51.096047Z] Running install step. 07:15:51 INFO - Running pre-action listener: _resource_record_pre_action 07:15:51 INFO - Running main action method: install 07:15:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:15:51 INFO - Reading from file tmpfile_stdout 07:15:51 INFO - Detecting whether we're running mozinstall >=1.0... 07:15:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:15:51 INFO - Reading from file tmpfile_stdout 07:15:51 INFO - Output received: 07:15:51 INFO - Usage: mozinstall [options] installer 07:15:51 INFO - Options: 07:15:51 INFO - -h, --help show this help message and exit 07:15:51 INFO - -d DEST, --destination=DEST 07:15:51 INFO - Directory to install application into. [default: 07:15:51 INFO - "/builds/slave/test"] 07:15:51 INFO - --app=APP Application being installed. [default: firefox] 07:15:51 INFO - mkdir: /builds/slave/test/build/application 07:15:51 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:15:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 07:16:07 INFO - Reading from file tmpfile_stdout 07:16:07 INFO - Output received: 07:16:07 INFO - /builds/slave/test/build/application/firefox/firefox 07:16:07 INFO - Running post-action listener: _resource_record_post_action 07:16:07 INFO - [mozharness: 2017-01-07 15:16:07.477845Z] Finished install step (success) 07:16:07 INFO - [mozharness: 2017-01-07 15:16:07.478187Z] Running run-tests step. 07:16:07 INFO - Running pre-action listener: _resource_record_pre_action 07:16:07 INFO - Running main action method: run_tests 07:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:16:07 INFO - Python 2.7.3 07:16:07 INFO - Return code: 0 07:16:07 INFO - grabbing minidump binary from tooltool 07:16:07 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:16:07 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 0x2652820>, '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 0x2653520>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x26539b0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:16:07 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:16:07 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:16:07 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:16:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:16:07 INFO - Return code: 0 07:16:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:16:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:16:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:16:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:16:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:16:07 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/btn9mzhtRzujZVq9U-TocA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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:16:07 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/btn9mzhtRzujZVq9U-TocA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-030 --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:16:07 INFO - Using env: {'DISPLAY': ':0', 07:16:07 INFO - 'HOME': '/home/cltbld', 07:16:07 INFO - 'LANG': 'en_US.UTF-8', 07:16:07 INFO - 'LANGUAGE': 'en_US:en', 07:16:07 INFO - 'LOGNAME': 'cltbld', 07:16:07 INFO - 'MAIL': '/var/mail/cltbld', 07:16:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:16:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:07 INFO - 'MOZ_NO_REMOTE': '1', 07:16:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:16:07 INFO - 'NO_EM_RESTART': '1', 07:16:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:07 INFO - 'PWD': '/builds/slave/test', 07:16:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:16:07 INFO - 'SHELL': '/bin/bash', 07:16:07 INFO - 'SHLVL': '1', 07:16:07 INFO - 'TERM': 'linux', 07:16:07 INFO - 'TMOUT': '86400', 07:16:07 INFO - 'USER': 'cltbld', 07:16:07 INFO - 'XDG_SESSION_COOKIE': '3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964', 07:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:07 INFO - '_': '/tools/buildbot/bin/python'} 07:16:07 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/btn9mzhtRzujZVq9U-TocA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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:16:07 INFO - mozversion application_buildid: 20170107143607 07:16:07 INFO - mozversion application_changeset: 178a3ce2f4fc9246da98af2d0c6519884ec677fa 07:16:07 INFO - mozversion application_display_name: Nightly 07:16:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:16:07 INFO - mozversion application_name: Firefox 07:16:07 INFO - mozversion application_remotingname: firefox 07:16:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:16:07 INFO - mozversion application_vendor: Mozilla 07:16:07 INFO - mozversion application_version: 53.0a1 07:16:07 INFO - mozversion platform_buildid: 20170107143607 07:16:07 INFO - mozversion platform_changeset: 178a3ce2f4fc9246da98af2d0c6519884ec677fa 07:16:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:16:07 INFO - mozversion platform_version: 53.0a1 07:16:07 INFO - using testdate: 1483802167 07:16:07 INFO - actual date: 1483802167 07:16:07 INFO - starting webserver on 'localhost:41226' 07:16:07 INFO - SUITE-START | Running 2 tests 07:16:07 INFO - TEST-START | dromaeo_css 07:16:07 INFO - operating with platform_type : linux_ 07:16:07 INFO - Initialising browser for dromaeo_css test... 07:16:07 INFO - TEST-INFO | started process 17620 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbwX5KM/profile http://localhost:41226/getInfo.html) 07:16:08 INFO - PROCESS | 17620 | 1483802168273 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 07:16:12 INFO - PROCESS | 17620 | __metrics Screen width/height:1600/1200 07:16:12 INFO - PROCESS | 17620 | colorDepth:24 07:16:12 INFO - PROCESS | 17620 | Browser inner width/height: 1024/697 07:16:12 INFO - PROCESS | 17620 | __metrics 07:16:12 ERROR - PROCESS | 17620 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 07:16:13 INFO - TEST-INFO | 17620: exit 0 07:16:13 INFO - Browser initialized. 07:16:13 INFO - Running cycle 1/1 for dromaeo_css test... 07:16:13 INFO - TEST-INFO | started process 17739 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbwX5KM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:16:25 INFO - PROCESS | 17739 | RSS: Main: 158400512 07:16:25 INFO - PROCESS | 17739 | 07:19:29 INFO - PROCESS | 17739 | Cycle 1(1): loaded http://localhost:41226/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41226/tests/dromaeo/cssquery-ext.html) 07:19:30 INFO - PROCESS | 17739 | RSS: Main: 165654528 07:19:30 INFO - PROCESS | 17739 | 07:21:14 INFO - PROCESS | 17739 | ************************* 07:21:14 INFO - PROCESS | 17739 | A coding exception was thrown and uncaught in a Task. 07:21:14 INFO - PROCESS | 17739 | 07:21:14 INFO - PROCESS | 17739 | Full message: ReferenceError: fetch is not defined 07:21:14 INFO - PROCESS | 17739 | Full stack: apiCall@resource://shield-recipe-client/lib/NormandyApi.jsm:37:5 07:21:14 INFO - PROCESS | 17739 | get@resource://shield-recipe-client/lib/NormandyApi.jsm:44:12 07:21:14 INFO - PROCESS | 17739 | this.NormandyApi.fetchRecipes<@resource://shield-recipe-client/lib/NormandyApi.jsm:52:34 07:21:14 INFO - PROCESS | 17739 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 07:21:14 INFO - PROCESS | 17739 | TaskImpl@resource://gre/modules/Task.jsm:277:3 07:21:14 INFO - PROCESS | 17739 | asyncFunction@resource://gre/modules/Task.jsm:252:14 07:21:14 INFO - PROCESS | 17739 | this.RecipeRunner.start<@resource://shield-recipe-client/lib/RecipeRunner.jsm:64:23 07:21:14 INFO - PROCESS | 17739 | TaskImpl_run@resource://gre/modules/Task.jsm:319:42 07:21:14 INFO - PROCESS | 17739 | TaskImpl@resource://gre/modules/Task.jsm:277:3 07:21:14 INFO - PROCESS | 17739 | asyncFunction@resource://gre/modules/Task.jsm:252:14 07:21:14 INFO - PROCESS | 17739 | setTimeout_timer@resource://gre/modules/Timer.jsm:30:5 07:21:14 INFO - PROCESS | 17739 | 07:21:14 INFO - PROCESS | 17739 | ************************* 07:22:33 INFO - PROCESS | 17739 | Cycle 1(1): loaded http://localhost:41226/tests/dromaeo/cssquery-ext.html (next: http://localhost:41226/tests/dromaeo/cssquery-jquery.html) 07:22:33 INFO - PROCESS | 17739 | RSS: Main: 162701312 07:22:33 INFO - PROCESS | 17739 | 07:25:35 INFO - PROCESS | 17739 | Cycle 1(1): loaded http://localhost:41226/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41226/tests/dromaeo/cssquery-mootools.html) 07:25:36 INFO - PROCESS | 17739 | RSS: Main: 167600128 07:25:36 INFO - PROCESS | 17739 | 07:28:38 INFO - PROCESS | 17739 | Cycle 1(1): loaded http://localhost:41226/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41226/tests/dromaeo/cssquery-prototype.html) 07:28:39 INFO - PROCESS | 17739 | RSS: Main: 162979840 07:28:39 INFO - PROCESS | 17739 | 07:31:42 INFO - PROCESS | 17739 | Cycle 1(1): loaded http://localhost:41226/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41226/tests/dromaeo/cssquery-yui.html) 07:31:42 INFO - PROCESS | 17739 | RSS: Main: 165470208 07:31:42 INFO - PROCESS | 17739 | 07:34:45 INFO - PROCESS | 17739 | Cycle 1(1): loaded http://localhost:41226/tests/dromaeo/cssquery-yui.html (next: http://localhost:41226/tests/dromaeo/cssquery-dojo.html) 07:34:46 INFO - PROCESS | 17739 | RSS: Main: 166309888 07:34:46 INFO - PROCESS | 17739 | 07:34:46 INFO - PROCESS | 17739 | __start_tp_report 07:34:46 INFO - PROCESS | 17739 | _x_x_mozilla_page_load 07:34:46 INFO - PROCESS | 17739 | _x_x_mozilla_page_load_details 07:34:46 INFO - PROCESS | 17739 | |i|pagename|runs| 07:34:46 INFO - PROCESS | 17739 | |0;dojo.html;2588.728183540728;2591.688997320322;2597.0780372967597;2614.4640348728512;2625.6061590761383;4538.909221815562;4674.48580656128;4686.133065382903;4690.085433340496;4732.90534189316;4611.907761844761;4630.722156670602;4673.205555055641;4700.647451441138;4746.62027037837;4305.6124948754605;4365.890852728683;4373.693841431101;4384.18892504886;4421.20418324703;4303.182395344875;4338.392625032482;4348.652107831366;4438.312061630452;4455.443069616298;4363.476382834048;4387.056782791683;4409.713368631044;4425.513193548707;4431.911361772763;4213.894652633678;4238.788060596958;4254.638355739766;4267.082577245876;4270.274053410928;4211.663066954637;4227.8097485613225;4242.4272723182285;4279.807408666617;4316.287812510932;4579.771011449414;4628.375169352128;4643.094596553673;4649.953500464986;4659;4874.731889746063;4903.730294833818;4943.134951383494;4996.4254110777;5037.949620503785;5106.617003724736;5107.233914912756;5111.744412779346;5120.641555091145;5163;4779.044191161747;4787.976060119747;4794.544518270759;4795.664303498722;4833.9999999999645;4977.751112444364;5040.36995375578;5041.269015992661;5202.557782588447;5258.2112683097075;4807.206810876236;4856.1016212000895;4859.246816743411;4868.9269660955115;4876.29293752411;4899.093667671492;4941.851744447672;4954.355933728664;4959.70241785494;4960.280759289955;4923.729194894244;4926.48271931442;4964.255361695775;4986.650934434555;5056.772445239973;4960.429550601655;5009.298698182258;5011.173156429221;5020.970701006285;5056.898862022739;4237.919330570747;4242.109157076987;4244.10873716523;4252.4259225004225;4284.721493102938;3592.946105808415;3634.890953271406;3638.599754027055;3657.74395792292;3674.6325367463573;4162.250794856895;4171.49942006955;4178.101708132766;4204.957950420457;4225.239456897726;4953.678010929278;4995.975020124876;5014.749262536859;5040.747962601855;5076.593872490192;4048.6356227939627;4076.30702780528;4143.56492568282;4186.330187170038;4229.069604686964;4456.197884380843;4482.596566309048;4498.392716983165;4510.864674059783;4514.7291162530355;4746.715197088186;4747.240441529339;4747.359106520576;4758.88102797419;4783.210770222944;4810.5670489656095;5062.620303477328;5065.974670126626;5070.797168113381;5100.030994111107;4615.30770384445;4697.882552936067;4736.242201247784;4754.049190162051;4807.399075115611;4784.712917224978;4978.103941290602;4979.950200498093;4982.8754281143265;5007.449180590205;4865.0756356292195;4886.877828054327;4934.481879402754;4941.876453088702;4968.552830245295;4543.091381723602;4593.747343895984;4694.2723877799;4703;4743.359646447823;4619.191641462798;4620.468646105741;4646.094011667692;4674.368960190331;4678.228092364721;4544.091181763727;4567.497575266651;4570.38299829532;4601.4248218972625;4656.9301460477445;4581.404417425713;4694;4694.765261736968;4709.916719154545;4749.9287510688055;4484.946037681077;4553.681242313006;4617.076584683144;4631.235846085358;4665.743384113906 07:34:46 INFO - PROCESS | 17739 | |1;ext.html;531.3650188025309;531.9122344813106;536.3510152715214;547.2256756689285;557.4091463049168;37627.81186094069;39848.20303593927;39898.99999999996;43239.56760432395;43333;40087;40801;40815;40870.59129408705;40872;7517.736879209242;7761.22387761225;7767.145613982458;7780.6109694515335;9543.236541076698;9438.103380178907;9691.563879625433;9712.320137590372;9731.318807683465;9732.805343893118;9702.320837541374;9718.271129665269;9767.413955162712;9773.413595184276;9776.120149186572;9702.22382209425;9741.172000379976;9751.609935602568;9758.512074396253;9774.804503909882;9475.90524094764;9597.616095356178;9613.90386096137;9614.423134611945;9615.711528654081;35101.47347789785;35254.47118293228;35342;35353.46969795455;35402;3576.088097535138;3635.563732352108;3652.7077833773233;3653.8173091345325;3669.6238910408597;25892.611610825854;26374.47251054968;26480.86759566209;26524.867375662998;26798.33004174892;3417.726581873444;3438.9312213755584;3558.3417067842533;3604.8377822998027;3610.4764809102535;237586;238955;239424;239489;240160.79919600463;47426.52573474221;47455.28817067678;47764.28353574699;47816.7609161952;47851.52148478471;49890;49941.75029124904;50119.24821127686;50155.498445015815;50261.24608130881;12085.697857553632;12378.319192444322;12397.442115104843;12411.379431028594;12418.316992565495;8906.287497000354;8957.14907083826;9179;9206.125418085272;9483.525823708787;16208.432704855273;16217.675646487005;16279.674406511804;16380.672386552202;16441;6356.792209480184;6442.06590044441;6559;6757.155355580552;6799.966000169968;792.7463211772293;802.181774589915;812.6789917982483;812.7114874219685;850.0606829453365;27197.45605087887;28284.575731364046;28312.292192694935;28665.426691466055;28738.425231495254;895.0646574329841;951.9476428796482;955.9713208603753;956.9521523923776;983.7098056073332;12631.621051368473;13207.735845283041;13275.269860157785;13355.465781368637;13430.529931452353;354409;354744;356439;357734.958552904;358381;43999.820017098325;44554;44567.331490027675;44627.33059004117;44715.10569788586;1195.1932445599186;1232.8458942632171;1238.6222202228407;1241.6026871401245;1245.1346314311465;22949.770502294763;23339.53320933606;23882.522349552564;24059;24491.38771530726;37297.81351093336;37925.431118533794;37955.43066853944;37963.15276354229;37969.81015095017;330134;332465;332849;333275;333365;23873.16443924454;24358.634620480352;24551.263462096165;24660.38349041288;26116.216513504627;38108.23783524369;38349.808250959686;38533.22933541257;38777.61222387853;39667;32299;32433.675663243066;32590.348193035534;32672.673273267916;34124.488132677536;31746.206344841565;31824.84087579547;32833.83583082165;32939;33681.15797105092;31443;32255.838720806245;32311.192220194684;32362;32587;28581.28546786347;28816.279593010342;29418.264543386587;29954.85022574873;29992;22765.430864227863;23023.07907683674;23112.884435577715;23283.301500955;23382.76617233806 07:34:46 INFO - PROCESS | 17739 | |2;jquery.html;377.9659830615244;381.29270203772006;383.2371092972328;400.1057636183132;402.0391264876945;17511.824881751178;18175.81824181758;18348.54128646783;18585.721214181798;18730.812691873096;17868;18003;18225.088745562734;18379.172937217823;18413.17140728667;5110.616703747224;5290.6825590464505;5299.920501192485;5325.547328477084;5335.306410166673;5153.6392452528335;5375.596830237748;5402.6758394496455;5492.670439773627;5494.945050549503;5400.918986215191;5495.917561236584;5501.559875209973;5515.586331025169;5517.503424691777;5448.700321482317;5492.752826122834;5515.531179849718;5522.502974732293;5538.3077115360375;5316.229146773696;5406.432324605899;5413.485718856702;5416.187571864212;5437.945620543823;11871.46578403974;11977.520899164023;11984.280943143352;11990.280583165038;12005.459754311078;2081.989590052055;2128.978710212909;2205.2391924786084;2249.347689170139;2263.739669937962;9254.953725231331;9511.857322140173;10168.084872361524;10518.737031574195;14082.929585352007;1739.7564340992271;1743.5728246579542;1750.8511776499013;1769.8230176982327;1772.8315809998157;66416.66791666059;67932;75697.24302756957;76103;76466.23533764647;9499.477528735986;10034.899651003396;10077.899221007696;10143.949280253551;10249.94875025635;13547;13596.320183990762;13597.388117534734;13608.727825443633;13619.114757540729;6891.862162756717;7103.680334384861;7148.785536433916;7234.842425211941;7311.524750891282;6383.170187875547;6437.710303036374;6618.172728408949;6727.260001399842;6862.348076932783;4208.473940757405;4217.578242175758;4221.556736542619;4260.55264197261;4339.522652508222;1890.4990177602947;1891.7162425636266;1919.7600299962505;1923.1345894347598;1944.8541359398102;800.1118758178417;818.9017317921888;818.9590520473953;828.6685325869701;846.191886748154;16690.4158354457;16763.161841907855;17443.82556174422;17478.475645730647;17770.555736106442;803.8030682482712;817.1379194949385;824.5712229640674;836.2014276366056;843.6119385082931;9114.680986165453;9409.576569054409;9668.274879384075;9721.854172187423;9789.237937171378;523835;532974;537597;541545;542274;67906.66046669833;80713.59643201747;88081.25488789682;90336.548317258;93619.53190234005;927.2628260532892;943.061653654618;967.1005964453126;970.5292932927524;971.1065819446127;14732;14797.482088126864;14997.850021499646;15169.469068582546;15180.848191517944;35499.645003550664;36088.4586731194;37750;41992.95017624584;42091.579084208766;52177.47822521726;54767.72616136894;54777;54805.45194548003;56228;5229.712365819764;5584.636998595079;7507.962460187882;7532.472726909064;8035.517868927883;9217.86173207389;12062.638120856389;12189.390530473618;12263.877361226274;12264.816027759412;10517.474126293502;10720.67837964831;10798.460076996276;11066;11196.94401527987;10450.163986881184;10492.213084018882;10646.520906559379;10710.357378557312;11018.228723989243;10186.286959913032;10400.27198096126;10518.631847885288;10595.94702026485;10612.575496980344;7564.962175189089;7669.463137580316;7719.459637825298;7802.219778022152;7867.527948323119;8237.711680091408;9960.651377201762;10322.916093810041;10450.529726162189;10496.317739346918 07:34:46 INFO - PROCESS | 17739 | |3;mootools.html;1300.1354099523817;1300.947962081517;1314.2180402660426;1320.5444121777982;1326.542342891702;5739.626924249921;5921;6202.410770976756;6627.304133066031;6634.834129146774;6388.105665206875;6571.441427478658;6578.375054369827;6683.966580167104;6719.160104986877;2072.202202152175;2107.7576078750985;2109.1457959526338;2109.2828438330966;2109.704641350212;1993.9700904486444;2072.8218982162007;2091.7699053104225;2105.452582328598;2109.704641350212;2058.8147066763986;2090.216168936649;2099.6745504446835;2103.6528972719484;2108.1356643776053;2005.3983804858485;2011.3362590345298;2038.347728726808;2051.887146206958;2056.033664177834;2037.0833125093768;2054.5069183396026;2071.332577275293;2077.1587507059667;2081.417203183096;6637.369449902251;6696.096027036385;6755.49333799967;6763.425108865752;6769;4139.441175441337;4270.039241170743;4280.807363668611;4282.400463935051;4308.3968244445805;2611.7518835710575;2828.8302701837956;2881.971180288191;2884.9855750721113;2900.1154647832404;1118.5637601335486;1119.0376276402287;1143.7712457508449;1147.6958605969426;1208.1301462946665;8449.155084491564;8449.662013519452;8468.534230617375;8484.618192181366;8502.617382217815;3550.183457804719;3713.814309284525;3731.8244752902747;3757.3800322946954;3788.1855401088897;7009.088818453569;7016.508844380946;7024.894626580605;7035.085438893014;7044.6125463099;4143.70994030421;4183;4184.7070705050355;4186.246475634415;4232.132412855357;3824.521934758155;3832.2335532892976;3904.7852368120025;3913.434626149506;3930.6265904739003;3007.5338322560037;3027.2885871820104;3095.520194369876;3100.488419410817;3204.455242608762;857.9485230886166;878.7715194049465;906.1663269791808;932.5477143585356;942.8821397325335;748.8914107454389;760.2853317881174;773.2769860180749;777.2033665492802;777.475204237149;4328.783560821947;4347.5217726050105;4356.934645980313;4406.9779651101535;4427.048184640318;836.4019725896013;850.4812064640564;855.4225897519274;876.9473831570126;884.5356188001351;2939.6619388770137;3044.6194225721783;3056.7401770849283;3072.2472994116583;3137.105924811418;7327.487075904635;7677.539347639159;7690.692372305157;7720.575368354682;7843.882341764878;7837.960810195913;7841.098273698483;7855.646495907584;7861.685532578633;7899.723509677134;6181.7527298908435;6273.404026617464;6276.435120839146;6281.214848143982;6298.1812364392335;4563.087382523442;4625.352450656978;4643.907121857476;4701.459332176843;4701.882452938704;7142.214356420685;7209.4592905533345;7214.639268036683;7323.63381830917;7372.557646541225;7298.416126709957;7303.488755787044;7338.926610733824;7374.852502950018;7401.851962960818;5706.4864162225595;5754.798582049608;5793.15999180125;5799.217105690678;5799.739011744566;6023.939760602513;6041.314927003709;6061.515078793598;6100.298465676504;6127.601705889103;5739.110437882135;5801.129830525455;5824.301083869963;5828.708564571839;5895.970520147372;5749.051406517878;5790.826275211751;5831.0378787499585;5838.708064596668;5910.52715782745;5000.699958002531;5100.362454693163;5116.283720279238;5121.231815227746;5122.948770512397;3881.9223615528094;3902.9609703902597;3948.1314110895555;4010.6791456682813;4070.8805078602436;4019.618136277049;4035.6569691576547;4062.2484840304637;4118.19695159453;4126.5667104953545 07:34:46 INFO - PROCESS | 17739 | |4;prototype.html;344.60370573840083;347.93911065563526;356.33543441481646;357.09298382109444;358.35853821659214;4808.591269742076;4922.926156107656;4984.401871775388;5027.924581131281;5028;4881.24340727187;4898.461169271377;4928.5564299213065;4934.185859333205;4935.284383764352;3837.980810095946;3839.6544311011935;3844.308024555579;3866.4780254665543;3867.38121900496;3746.3069332173636;3838.596947320533;3860.652541271285;3867.2265546890594;3882.388808644409;3768.792716400597;3772.6793222575975;3804.896579991799;3807.505024346845;3817.7518461300065;3773.1510410157634;3785.3754130568423;3790.166163444038;3802.4106263529197;3822.789746563938;3330.20075181957;3342.9636812588174;3344.5986481622363;3347.610741542257;3349.5213541979006;4697.436307643071;4772.832950846704;4838.983813399191;4884.511548845123;4900.505345869544;4328.913421731548;4330.848420305306;4341.39220509129;4353.760543170124;4366.8253269869165;5141.15170996785;5191.039657663345;5211.088059589557;5215.191645294985;5241.161414173752;3651.707863370924;3656.287024030315;3690.741648084635;3694.5751238607636;3694.612065733113;5148.716820574867;5387.380451248117;5418.160185171305;5434.945650543523;5448.863778405532;3672.7429079964145;3697.8335974880656;3720.4605332226674;3727;3728.8508459661853;3760.360738674432;3775.6601905828607;3775.9433608495897;3781.4138808484727;3794.317022935898;4116.794160291974;4281.91436171281;4308.332208507686;4357.520672725997;4365.410669559569;5129.153689641242;5150.613703972217;5151.407588127413;5160.200168973815;5195.558377537876;1226.5400474821943;1254;1254.956076537317;1273.5096987659817;1285.1582213650074;835.774340927946;861.6940985950023;864.8097418567905;870.3907264914585;879.7448739865496;4198.685098617616;4200.537940826506;4213;4228.112096459778;4230.323148296257;5063.670861393997;5090.669106508065;5111.667741596784;5114.335136432314;5122.410922743858;4163.354680024601;4216.789160541961;4218.578142185818;4220.530989371191;4245.511766146933;2599.7261341942312;2674.473021278297;2682.9463410732064;2689.8117131800586;2723.2919440945498;4790.802299425144;4793.376861008116;4802.183628783116;4806.49531799163;4816.242071643825;5235.8481134150425;5239.371275446894;5246.449122842123;5253.579713622901;5292.153255479105;4622.86131416058;4920.6309526785635;4967.950320496893;4975.9847261859;4994.3507344045765;5257.237700533477;5282.762275697526;5292.126799078109;5307.54885834693;5307.761150748149;4951.257311403318;5244.475552444725;5251.159814429673;5262.605304602093;5268.604854635994;4937.728424936519;4963.205887058053;4968.22992436173;4989.151844186569;4996.127226844506;3729.606058486764;3738.981305093457;3749.6625303722794;3780.4707340972836;3781;4840.75796210181;5358.839234822962;5369.926014796978;5370.785168593213;5374.435684253253;4952.4057113146655;4969.552740253394;4971.975140124277;4982.352294201731;4993;4969.950300497093;4977.651564390603;4983.5763960063805;4994.775235114501;5007.298978143136;4761.214399624023;4857.9028419432125;4870.586000190024;4917.336159618406;4921.188003979303;5000.424951130666;5004.347695721273;5025.346704928336;5028.723420211923;5043.789490522322;4905.509449055208;4909.926351104665;4913;4933.802647894044;4959.429665588504 07:34:46 INFO - PROCESS | 17739 | |5;yui.html;678.525032477266;682.7132604306191;739.71890681541;772.2856357868972;784.8626490364187;12635.178713383624;13475.932620336896;13587.864121358783;13616.659583510418;13617.863821361783;13012.089153759242;13040.73918521629;13053.151545149558;13062.934685326583;13082;647.4820143884897;681.6591704147926;772.6793380746983;788.562347896917;808.0828259924969;801.8797180422924;816;817.2236375443352;818.5048045932215;819.1562690428868;865.6061492021115;866.8093019535692;869.3957699398889;870.4342177584557;871.0375035585681;862.516990485324;862.7454900804278;862.7886167888876;863.0420233540765;863.1109956744563;631.7946667333135;632.6457183976942;634.3022675057446;638.157631925858;638.6104476269472;13971.441142354293;14126.293685315795;14221.715565688732;14408.351624176938;14431;13508;13771.724565508634;14323.35544900482;14391.928040359731;14588.70822583553;11183.496742646601;11275.718107047389;11279.097672186206;11282.774344513064;11410.258333208314;3274.8690052397874;3284.934301313984;3293.2096296888813;3307.6526964668847;3425;66365;66448;67371;68329.31670683328;68464.6576767118;10552.366857988545;10556.947215263874;10755.462226888625;10760.838587421194;10935.179861510418;21361;21384.251551195946;21438.356849294545;21441.249556265455;21461.89269053676;6780.118584583973;6855.457522057497;7042.084529011196;7133.607651579109;7138.643067846587;3712.230072742999;3825.5218097737784;3830.291396091732;3858.2090671412293;3861.2084522672785;2908.6218791557385;2980.1357606294364;2984.686607906182;2992.5511173324176;3008.744256738202;483.68560435717063;492.1633223519959;494.7575687912969;496.74417674897455;502.02105893507803;613.5582380685898;632.6109442692803;645.3578689204178;647.2233320015999;648.9091527186198;8399.790005249795;8624.353173512012;8681.826363472821;8836.734897953073;8960.551972401354;624.7438550194398;635.5646382228189;645.7578408096964;654.7217432591129;657.7763560389491;3966.6628336591134;4021.718479706451;4031.0930040741187;4076.144009757984;4098.446709694213;64162.67918660377;64339;65514;66324;69246.307536925;57163;57330.713346433;57585.712071439375;58203;58761;53215.46784532105;53303.46696533063;53531.46468535343;53724.462755372726;54890.451095489334;7614.771556853303;7820.687172513036;7910.52536847791;8080.474769139987;8089.919100809152;35977.64022359848;36444.635553644126;37247.81376093102;38024.80987595044;38464.80767596144;43132.137357253305;45178.322325165806;45567.54432455633;46795.532044679116;47372.2894156581;9804.313698041355;9878.259130565093;9992.950035249778;10005.099541041342;10120.392776433437;10645.574177032831;10697.304675196086;10811.513481893491;11251.49368278413;11276.32342059479;10256.48717564104;10519.105876000625;10700.946495267473;10824.296420732628;10843.349399036084;10632.734181645521;10918.290311129751;11124.777504450027;11128.721781955515;11135.610253641084;9900.356476828983;10191.796164076824;10275.280730349103;10567.735806604589;10666.946665266623;8552.914470855212;8595.484270943763;8674.349423793115;8716.302695784196;8828.911710882809;8224;8351.707690230813;8464.661413543636;8478.236958673502;8701.52141632191 07:34:46 INFO - PROCESS | 17739 | __end_tp_report 07:34:46 INFO - PROCESS | 17739 | __start_cc_report 07:34:46 INFO - PROCESS | 17739 | _x_x_mozilla_cycle_collect,357 07:34:46 INFO - PROCESS | 17739 | __end_cc_report 07:34:46 INFO - PROCESS | 17739 | __startTimestamp1483803286065__endTimestamp 07:34:46 INFO - PROCESS | 17739 | 07:34:46 INFO - PROCESS | 17739 | ------- Summary: start ------- 07:34:46 INFO - PROCESS | 17739 | Number of tests: 6 07:34:46 INFO - PROCESS | 17739 | 07:34:46 INFO - PROCESS | 17739 | [#0] dojo.html Cycles:165 Average:4583.14 Median:4674.49 stddev:484.38 (10.4%) stddev-sans-first:459.90 07:34:46 INFO - PROCESS | 17739 | Values: 2588.7 2591.7 2597.1 2614.5 2625.6 4538.9 4674.5 4686.1 4690.1 4732.9 4611.9 4630.7 4673.2 4700.6 4746.6 4305.6 4365.9 4373.7 4384.2 4421.2 4303.2 4338.4 4348.7 4438.3 4455.4 4363.5 4387.1 4409.7 4425.5 4431.9 4213.9 4238.8 4254.6 4267.1 4270.3 4211.7 4227.8 4242.4 4279.8 4316.3 4579.8 4628.4 4643.1 4650.0 4659.0 4874.7 4903.7 4943.1 4996.4 5037.9 5106.6 5107.2 5111.7 5120.6 5163.0 4779.0 4788.0 4794.5 4795.7 4834.0 4977.8 5040.4 5041.3 5202.6 5258.2 4807.2 4856.1 4859.2 4868.9 4876.3 4899.1 4941.9 4954.4 4959.7 4960.3 4923.7 4926.5 4964.3 4986.7 5056.8 4960.4 5009.3 5011.2 5021.0 5056.9 4237.9 4242.1 4244.1 4252.4 4284.7 3592.9 3634.9 3638.6 3657.7 3674.6 4162.3 4171.5 4178.1 4205.0 4225.2 4953.7 4996.0 5014.7 5040.7 5076.6 4048.6 4076.3 4143.6 4186.3 4229.1 4456.2 4482.6 4498.4 4510.9 4514.7 4746.7 4747.2 4747.4 4758.9 4783.2 4810.6 5062.6 5066.0 5070.8 5100.0 4615.3 4697.9 4736.2 4754.0 4807.4 4784.7 4978.1 4980.0 4982.9 5007.4 4865.1 4886.9 4934.5 4941.9 4968.6 4543.1 4593.7 4694.3 4703.0 4743.4 4619.2 4620.5 4646.1 4674.4 4678.2 4544.1 4567.5 4570.4 4601.4 4656.9 4581.4 4694.0 4694.8 4709.9 4749.9 4484.9 4553.7 4617.1 4631.2 4665.7 07:34:46 INFO - PROCESS | 17739 | 07:34:46 INFO - PROCESS | 17739 | [#1] ext.html Cycles:180 Average:45323.62 Median:3623.02 stddev:82455.86 (2275.9%) stddev-sans-first:82618.58 07:34:46 INFO - PROCESS | 17739 | Values: 531.4 531.9 536.4 547.2 557.4 37627.8 39848.2 39899.0 43239.6 43333.0 40087.0 40801.0 40815.0 40870.6 40872.0 7517.7 7761.2 7767.1 7780.6 9543.2 9438.1 9691.6 9712.3 9731.3 9732.8 9702.3 9718.3 9767.4 9773.4 9776.1 9702.2 9741.2 9751.6 9758.5 9774.8 9475.9 9597.6 9613.9 9614.4 9615.7 35101.5 35254.5 35342.0 35353.5 35402.0 3576.1 3635.6 3652.7 3653.8 3669.6 25892.6 26374.5 26480.9 26524.9 26798.3 3417.7 3438.9 3558.3 3604.8 3610.5 237586.0 238955.0 239424.0 239489.0 240160.8 47426.5 47455.3 47764.3 47816.8 47851.5 49890.0 49941.8 50119.2 50155.5 50261.2 12085.7 12378.3 12397.4 12411.4 12418.3 8906.3 8957.1 9179.0 9206.1 9483.5 16208.4 16217.7 16279.7 16380.7 16441.0 6356.8 6442.1 6559.0 6757.2 6800.0 792.7 802.2 812.7 812.7 850.1 27197.5 28284.6 28312.3 28665.4 28738.4 895.1 951.9 956.0 957.0 983.7 12631.6 13207.7 13275.3 13355.5 13430.5 354409.0 354744.0 356439.0 357735.0 358381.0 43999.8 44554.0 44567.3 44627.3 44715.1 1195.2 1232.8 1238.6 1241.6 1245.1 22949.8 23339.5 23882.5 24059.0 24491.4 37297.8 37925.4 37955.4 37963.2 37969.8 330134.0 332465.0 332849.0 333275.0 333365.0 23873.2 24358.6 24551.3 24660.4 26116.2 38108.2 38349.8 38533.2 38777.6 39667.0 32299.0 32433.7 32590.3 32672.7 34124.5 31746.2 31824.8 32833.8 32939.0 33681.2 31443.0 32255.8 32311.2 32362.0 32587.0 28581.3 28816.3 29418.3 29954.9 29992.0 22765.4 23023.1 23112.9 23283.3 23382.8 07:34:46 INFO - PROCESS | 17739 | 07:34:46 INFO - PROCESS | 17739 | [#2] jquery.html Cycles:180 Average:28662.90 Median:28665.56 stddev:87976.40 (306.9%) stddev-sans-first:88197.56 07:34:46 INFO - PROCESS | 17739 | Values: 378.0 381.3 383.2 400.1 402.0 17511.8 18175.8 18348.5 18585.7 18730.8 17868.0 18003.0 18225.1 18379.2 18413.2 5110.6 5290.7 5299.9 5325.5 5335.3 5153.6 5375.6 5402.7 5492.7 5494.9 5400.9 5495.9 5501.6 5515.6 5517.5 5448.7 5492.8 5515.5 5522.5 5538.3 5316.2 5406.4 5413.5 5416.2 5437.9 11871.5 11977.5 11984.3 11990.3 12005.5 2082.0 2129.0 2205.2 2249.3 2263.7 9255.0 9511.9 10168.1 10518.7 14082.9 1739.8 1743.6 1750.9 1769.8 1772.8 66416.7 67932.0 75697.2 76103.0 76466.2 9499.5 10034.9 10077.9 10143.9 10249.9 13547.0 13596.3 13597.4 13608.7 13619.1 6891.9 7103.7 7148.8 7234.8 7311.5 6383.2 6437.7 6618.2 6727.3 6862.3 4208.5 4217.6 4221.6 4260.6 4339.5 1890.5 1891.7 1919.8 1923.1 1944.9 800.1 818.9 819.0 828.7 846.2 16690.4 16763.2 17443.8 17478.5 17770.6 803.8 817.1 824.6 836.2 843.6 9114.7 9409.6 9668.3 9721.9 9789.2 523835.0 532974.0 537597.0 541545.0 542274.0 67906.7 80713.6 88081.3 90336.5 93619.5 927.3 943.1 967.1 970.5 971.1 14732.0 14797.5 14997.9 15169.5 15180.8 35499.6 36088.5 37750.0 41993.0 42091.6 52177.5 54767.7 54777.0 54805.5 56228.0 5229.7 5584.6 7508.0 7532.5 8035.5 9217.9 12062.6 12189.4 12263.9 12264.8 10517.5 10720.7 10798.5 11066.0 11196.9 10450.2 10492.2 10646.5 10710.4 11018.2 10186.3 10400.3 10518.6 10595.9 10612.6 7565.0 7669.5 7719.5 7802.2 7867.5 8237.7 9960.7 10322.9 10450.5 10496.3 07:34:46 INFO - PROCESS | 17739 | 07:34:46 INFO - PROCESS | 17739 | [#3] mootools.html Cycles:180 Average:4371.75 Median:5050.53 stddev:2251.97 (44.6%) stddev-sans-first:2246.46 07:34:46 INFO - PROCESS | 17739 | Values: 1300.1 1300.9 1314.2 1320.5 1326.5 5739.6 5921.0 6202.4 6627.3 6634.8 6388.1 6571.4 6578.4 6684.0 6719.2 2072.2 2107.8 2109.1 2109.3 2109.7 1994.0 2072.8 2091.8 2105.5 2109.7 2058.8 2090.2 2099.7 2103.7 2108.1 2005.4 2011.3 2038.3 2051.9 2056.0 2037.1 2054.5 2071.3 2077.2 2081.4 6637.4 6696.1 6755.5 6763.4 6769.0 4139.4 4270.0 4280.8 4282.4 4308.4 2611.8 2828.8 2882.0 2885.0 2900.1 1118.6 1119.0 1143.8 1147.7 1208.1 8449.2 8449.7 8468.5 8484.6 8502.6 3550.2 3713.8 3731.8 3757.4 3788.2 7009.1 7016.5 7024.9 7035.1 7044.6 4143.7 4183.0 4184.7 4186.2 4232.1 3824.5 3832.2 3904.8 3913.4 3930.6 3007.5 3027.3 3095.5 3100.5 3204.5 857.9 878.8 906.2 932.5 942.9 748.9 760.3 773.3 777.2 777.5 4328.8 4347.5 4356.9 4407.0 4427.0 836.4 850.5 855.4 876.9 884.5 2939.7 3044.6 3056.7 3072.2 3137.1 7327.5 7677.5 7690.7 7720.6 7843.9 7838.0 7841.1 7855.6 7861.7 7899.7 6181.8 6273.4 6276.4 6281.2 6298.2 4563.1 4625.4 4643.9 4701.5 4701.9 7142.2 7209.5 7214.6 7323.6 7372.6 7298.4 7303.5 7338.9 7374.9 7401.9 5706.5 5754.8 5793.2 5799.2 5799.7 6023.9 6041.3 6061.5 6100.3 6127.6 5739.1 5801.1 5824.3 5828.7 5896.0 5749.1 5790.8 5831.0 5838.7 5910.5 5000.7 5100.4 5116.3 5121.2 5122.9 3881.9 3903.0 3948.1 4010.7 4070.9 4019.6 4035.7 4062.2 4118.2 4126.6 07:34:46 INFO - PROCESS | 17739 | 07:34:46 INFO - PROCESS | 17739 | [#4] prototype.html Cycles:180 Average:4214.01 Median:4839.87 stddev:1222.98 (25.3%) stddev-sans-first:1191.43 07:34:46 INFO - PROCESS | 17739 | Values: 344.6 347.9 356.3 357.1 358.4 4808.6 4922.9 4984.4 5027.9 5028.0 4881.2 4898.5 4928.6 4934.2 4935.3 3838.0 3839.7 3844.3 3866.5 3867.4 3746.3 3838.6 3860.7 3867.2 3882.4 3768.8 3772.7 3804.9 3807.5 3817.8 3773.2 3785.4 3790.2 3802.4 3822.8 3330.2 3343.0 3344.6 3347.6 3349.5 4697.4 4772.8 4839.0 4884.5 4900.5 4328.9 4330.8 4341.4 4353.8 4366.8 5141.2 5191.0 5211.1 5215.2 5241.2 3651.7 3656.3 3690.7 3694.6 3694.6 5148.7 5387.4 5418.2 5434.9 5448.9 3672.7 3697.8 3720.5 3727.0 3728.9 3760.4 3775.7 3775.9 3781.4 3794.3 4116.8 4281.9 4308.3 4357.5 4365.4 5129.2 5150.6 5151.4 5160.2 5195.6 1226.5 1254.0 1255.0 1273.5 1285.2 835.8 861.7 864.8 870.4 879.7 4198.7 4200.5 4213.0 4228.1 4230.3 5063.7 5090.7 5111.7 5114.3 5122.4 4163.4 4216.8 4218.6 4220.5 4245.5 2599.7 2674.5 2682.9 2689.8 2723.3 4790.8 4793.4 4802.2 4806.5 4816.2 5235.8 5239.4 5246.4 5253.6 5292.2 4622.9 4920.6 4968.0 4976.0 4994.4 5257.2 5282.8 5292.1 5307.5 5307.8 4951.3 5244.5 5251.2 5262.6 5268.6 4937.7 4963.2 4968.2 4989.2 4996.1 3729.6 3739.0 3749.7 3780.5 3781.0 4840.8 5358.8 5369.9 5370.8 5374.4 4952.4 4969.6 4972.0 4982.4 4993.0 4970.0 4977.7 4983.6 4994.8 5007.3 4761.2 4857.9 4870.6 4917.3 4921.2 5000.4 5004.3 5025.3 5028.7 5043.8 4905.5 4909.9 4913.0 4933.8 4959.4 07:34:46 INFO - PROCESS | 17739 | 07:34:46 INFO - PROCESS | 17739 | [#5] yui.html Cycles:180 Average:15000.51 Median:26858.74 stddev:18975.95 (70.7%) stddev-sans-first:18998.71 07:34:46 INFO - PROCESS | 17739 | Values: 678.5 682.7 739.7 772.3 784.9 12635.2 13475.9 13587.9 13616.7 13617.9 13012.1 13040.7 13053.2 13062.9 13082.0 647.5 681.7 772.7 788.6 808.1 801.9 816.0 817.2 818.5 819.2 865.6 866.8 869.4 870.4 871.0 862.5 862.7 862.8 863.0 863.1 631.8 632.6 634.3 638.2 638.6 13971.4 14126.3 14221.7 14408.4 14431.0 13508.0 13771.7 14323.4 14391.9 14588.7 11183.5 11275.7 11279.1 11282.8 11410.3 3274.9 3284.9 3293.2 3307.7 3425.0 66365.0 66448.0 67371.0 68329.3 68464.7 10552.4 10556.9 10755.5 10760.8 10935.2 21361.0 21384.3 21438.4 21441.2 21461.9 6780.1 6855.5 7042.1 7133.6 7138.6 3712.2 3825.5 3830.3 3858.2 3861.2 2908.6 2980.1 2984.7 2992.6 3008.7 483.7 492.2 494.8 496.7 502.0 613.6 632.6 645.4 647.2 648.9 8399.8 8624.4 8681.8 8836.7 8960.6 624.7 635.6 645.8 654.7 657.8 3966.7 4021.7 4031.1 4076.1 4098.4 64162.7 64339.0 65514.0 66324.0 69246.3 57163.0 57330.7 57585.7 58203.0 58761.0 53215.5 53303.5 53531.5 53724.5 54890.5 7614.8 7820.7 7910.5 8080.5 8089.9 35977.6 36444.6 37247.8 38024.8 38464.8 43132.1 45178.3 45567.5 46795.5 47372.3 9804.3 9878.3 9993.0 10005.1 10120.4 10645.6 10697.3 10811.5 11251.5 11276.3 10256.5 10519.1 10700.9 10824.3 10843.3 10632.7 10918.3 11124.8 11128.7 11135.6 9900.4 10191.8 10275.3 10567.7 10666.9 8552.9 8595.5 8674.3 8716.3 8828.9 8224.0 8351.7 8464.7 8478.2 8701.5 07:34:46 INFO - PROCESS | 17739 | -------- Summary: end -------- 07:34:46 INFO - PROCESS | 17739 | 07:34:46 INFO - TEST-INFO | 17739: exit 0 07:34:46 INFO - TEST-OK | dromaeo_css | took 1119172ms 07:34:46 INFO - TEST-START | kraken 07:34:46 INFO - operating with platform_type : linux_ 07:34:46 INFO - Initialising browser for kraken test... 07:34:46 INFO - TEST-INFO | started process 18096 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdGT8ue/profile http://localhost:41226/getInfo.html) 07:34:47 INFO - PROCESS | 18096 | 1483803287435 addons.xpi WARN Exception running bootstrap method install on shield-recipe-client@mozilla.org: [Exception... "Component returned failure code: 0x8000ffff (NS_ERROR_UNEXPECTED) [nsIPrefBranch.getBoolPref]" nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js :: this.install :: line 38" data: no] Stack trace: this.install()@resource://gre/modules/addons/XPIProvider.jsm -> jar:file:///builds/slave/test/build/application/firefox/browser/features/shield-recipe-client@mozilla.org.xpi!/bootstrap.js:38 < callBootstrapMethod()@resource://gre/modules/addons/XPIProvider.jsm:4907 < processFileChanges()@resource://gre/modules/addons/XPIProvider.jsm -> resource://gre/modules/addons/XPIProviderUtils.js:2060 < checkForChanges()@resource://gre/modules/addons/XPIProvider.jsm:3762 < startup()@resource://gre/modules/addons/XPIProvider.jsm:2795 < callProvider()@resource://gre/modules/AddonManager.jsm:267 < _startProvider()@resource://gre/modules/AddonManager.jsm:973 < startup()@resource://gre/modules/AddonManager.jsm:1155 < startup()@resource://gre/modules/AddonManager.jsm:3124 < observe()@resource://gre/components/addonManager.js:65 07:34:51 INFO - PROCESS | 18096 | __metrics Screen width/height:1600/1200 07:34:51 INFO - PROCESS | 18096 | colorDepth:24 07:34:51 INFO - PROCESS | 18096 | Browser inner width/height: 1024/697 07:34:51 INFO - PROCESS | 18096 | __metrics 07:34:52 ERROR - PROCESS | 18096 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3252: TypeError: this.tabs is undefined 07:34:53 INFO - TEST-INFO | 18096: exit 0 07:34:53 INFO - Browser initialized. 07:34:53 INFO - Running cycle 1/1 for kraken test... 07:34:53 INFO - TEST-INFO | started process 18215 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdGT8ue/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:35:05 INFO - PROCESS | 18215 | RSS: Main: 158445568 07:35:05 INFO - PROCESS | 18215 | 07:35:07 INFO - PROCESS | 18215 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41226/tests/kraken/driver.html?testName=audio-beat-detection) 07:35:08 INFO - PROCESS | 18215 | RSS: Main: 164663296 07:35:08 INFO - PROCESS | 18215 | 07:35:11 INFO - PROCESS | 18215 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41226/tests/kraken/driver.html?testName=audio-dft) 07:35:12 INFO - PROCESS | 18215 | RSS: Main: 163708928 07:35:12 INFO - PROCESS | 18215 | 07:35:15 INFO - PROCESS | 18215 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41226/tests/kraken/driver.html?testName=audio-fft) 07:35:15 INFO - PROCESS | 18215 | RSS: Main: 160239616 07:35:15 INFO - PROCESS | 18215 | 07:35:17 INFO - PROCESS | 18215 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41226/tests/kraken/driver.html?testName=audio-oscillator) 07:35:18 INFO - PROCESS | 18215 | RSS: Main: 160792576 07:35:18 INFO - PROCESS | 18215 | 07:35:20 INFO - PROCESS | 18215 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41226/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:35:21 INFO - PROCESS | 18215 | RSS: Main: 160923648 07:35:21 INFO - PROCESS | 18215 | 07:35:24 INFO - PROCESS | 18215 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41226/tests/kraken/driver.html?testName=imaging-darkroom) 07:35:25 INFO - PROCESS | 18215 | RSS: Main: 165613568 07:35:25 INFO - PROCESS | 18215 | 07:35:28 INFO - PROCESS | 18215 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41226/tests/kraken/driver.html?testName=imaging-desaturate) 07:35:29 INFO - PROCESS | 18215 | RSS: Main: 161918976 07:35:29 INFO - PROCESS | 18215 | 07:35:32 INFO - PROCESS | 18215 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41226/tests/kraken/driver.html?testName=json-parse-financial) 07:35:32 INFO - PROCESS | 18215 | RSS: Main: 163143680 07:35:32 INFO - PROCESS | 18215 | 07:35:34 INFO - PROCESS | 18215 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41226/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:35:35 INFO - PROCESS | 18215 | RSS: Main: 163147776 07:35:35 INFO - PROCESS | 18215 | 07:35:37 INFO - PROCESS | 18215 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41226/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:35:37 INFO - PROCESS | 18215 | RSS: Main: 162922496 07:35:37 INFO - PROCESS | 18215 | 07:35:40 INFO - PROCESS | 18215 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41226/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:35:40 INFO - PROCESS | 18215 | RSS: Main: 163377152 07:35:40 INFO - PROCESS | 18215 | 07:35:43 INFO - PROCESS | 18215 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41226/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:35:44 INFO - PROCESS | 18215 | RSS: Main: 163667968 07:35:44 INFO - PROCESS | 18215 | 07:35:47 INFO - PROCESS | 18215 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41226/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:35:47 INFO - PROCESS | 18215 | RSS: Main: 163651584 07:35:47 INFO - PROCESS | 18215 | 07:35:49 INFO - PROCESS | 18215 | Cycle 1(1): loaded http://localhost:41226/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41226/tests/kraken/driver.html?testName=ai-astar) 07:35:49 INFO - PROCESS | 18215 | RSS: Main: 165392384 07:35:49 INFO - PROCESS | 18215 | 07:35:49 INFO - PROCESS | 18215 | __start_tp_report 07:35:49 INFO - PROCESS | 18215 | _x_x_mozilla_page_load 07:35:49 INFO - PROCESS | 18215 | _x_x_mozilla_page_load_details 07:35:49 INFO - PROCESS | 18215 | |i|pagename|runs| 07:35:49 INFO - PROCESS | 18215 | |0;ai-astar;109;115;116;116;115;115;116;116;115;116 07:35:49 INFO - PROCESS | 18215 | |1;audio-beat-detection;154;123;131;178;130;129;127;128;147;126 07:35:49 INFO - PROCESS | 18215 | |2;audio-dft;166;164;166;174;164;163;162;164;163;162 07:35:49 INFO - PROCESS | 18215 | |3;audio-fft;75;77;76;109;78;77;78;77;96;76 07:35:49 INFO - PROCESS | 18215 | |4;audio-oscillator;86;84;112;86;86;85;96;86;86;112 07:35:49 INFO - PROCESS | 18215 | |5;imaging-gaussian-blur;117;118;118;118;119;120;118;118;118;119 07:35:49 INFO - PROCESS | 18215 | |6;imaging-darkroom;152;154;151;153;152;151;151;152;152;151 07:35:49 INFO - PROCESS | 18215 | |7;imaging-desaturate;96;97;96;96;96;95;96;96;96;96 07:35:49 INFO - PROCESS | 18215 | |8;json-parse-financial;75;65;64;65;66;67;65;66;66;65 07:35:49 INFO - PROCESS | 18215 | |9;json-stringify-tinderbox;69;68;67;68;68;72;68;68;68;67 07:35:49 INFO - PROCESS | 18215 | |10;stanford-crypto-aes;90;85;86;89;88;86;90;91;88;92 07:35:49 INFO - PROCESS | 18215 | |11;stanford-crypto-ccm;145;134;136;134;142;134;136;139;190;133 07:35:49 INFO - PROCESS | 18215 | |12;stanford-crypto-pbkdf2;179;180;179;182;182;180;182;180;183;180 07:35:49 INFO - PROCESS | 18215 | |13;stanford-crypto-sha256-iterative;69;71;69;71;72;70;67;68;69;67 07:35:49 INFO - PROCESS | 18215 | __end_tp_report 07:35:49 INFO - PROCESS | 18215 | __start_cc_report 07:35:49 INFO - PROCESS | 18215 | _x_x_mozilla_cycle_collect,819 07:35:49 INFO - PROCESS | 18215 | __end_cc_report 07:35:49 INFO - PROCESS | 18215 | __startTimestamp1483803349926__endTimestamp 07:35:49 INFO - PROCESS | 18215 | 07:35:49 INFO - PROCESS | 18215 | ------- Summary: start ------- 07:35:49 INFO - PROCESS | 18215 | Number of tests: 14 07:35:49 INFO - PROCESS | 18215 | 07:35:49 INFO - PROCESS | 18215 | [#0] ai-astar Cycles:10 Average:114.90 Median:116.00 stddev:2.13 (1.8%) stddev-sans-first:0.53 07:35:49 INFO - PROCESS | 18215 | Values: 109.0 115.0 116.0 116.0 115.0 115.0 116.0 116.0 115.0 116.0 07:35:49 INFO - PROCESS | 18215 | 07:35:49 INFO - PROCESS | 18215 | [#1] audio-beat-detection Cycles:10 Average:137.30 Median:130.50 stddev:17.37 (13.3%) stddev-sans-first:17.34 07:35:49 INFO - PROCESS | 18215 | Values: 154.0 123.0 131.0 178.0 130.0 129.0 127.0 128.0 147.0 126.0 07:35:49 INFO - PROCESS | 18215 | 07:35:49 INFO - PROCESS | 18215 | [#2] audio-dft Cycles:10 Average:164.80 Median:164.00 stddev:3.52 (2.1%) stddev-sans-first:3.71 07:35:49 INFO - PROCESS | 18215 | Values: 166.0 164.0 166.0 174.0 164.0 163.0 162.0 164.0 163.0 162.0 07:35:49 INFO - PROCESS | 18215 | 07:35:49 INFO - PROCESS | 18215 | [#3] audio-fft Cycles:10 Average:81.90 Median:77.00 stddev:11.32 (14.7%) stddev-sans-first:11.73 07:35:49 INFO - PROCESS | 18215 | Values: 75.0 77.0 76.0 109.0 78.0 77.0 78.0 77.0 96.0 76.0 07:35:49 INFO - PROCESS | 18215 | 07:35:49 INFO - PROCESS | 18215 | [#4] audio-oscillator Cycles:10 Average:91.90 Median:86.00 stddev:11.10 (12.9%) stddev-sans-first:11.57 07:35:49 INFO - PROCESS | 18215 | Values: 86.0 84.0 112.0 86.0 86.0 85.0 96.0 86.0 86.0 112.0 07:35:49 INFO - PROCESS | 18215 | 07:35:49 INFO - PROCESS | 18215 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.73 07:35:49 INFO - PROCESS | 18215 | Values: 117.0 118.0 118.0 118.0 119.0 120.0 118.0 118.0 118.0 119.0 07:35:49 INFO - PROCESS | 18215 | 07:35:49 INFO - PROCESS | 18215 | [#6] imaging-darkroom Cycles:10 Average:151.90 Median:152.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 07:35:49 INFO - PROCESS | 18215 | Values: 152.0 154.0 151.0 153.0 152.0 151.0 151.0 152.0 152.0 151.0 07:35:49 INFO - PROCESS | 18215 | 07:35:49 INFO - PROCESS | 18215 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 07:35:49 INFO - PROCESS | 18215 | Values: 96.0 97.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 07:35:49 INFO - PROCESS | 18215 | 07:35:49 INFO - PROCESS | 18215 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:66.00 stddev:3.13 (4.7%) stddev-sans-first:0.88 07:35:49 INFO - PROCESS | 18215 | Values: 75.0 65.0 64.0 65.0 66.0 67.0 65.0 66.0 66.0 65.0 07:35:49 INFO - PROCESS | 18215 | 07:35:49 INFO - PROCESS | 18215 | [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:1.42 (2.1%) stddev-sans-first:1.48 07:35:49 INFO - PROCESS | 18215 | Values: 69.0 68.0 67.0 68.0 68.0 72.0 68.0 68.0 68.0 67.0 07:35:49 INFO - PROCESS | 18215 | 07:35:49 INFO - PROCESS | 18215 | [#10] stanford-crypto-aes Cycles:10 Average:88.50 Median:89.50 stddev:2.32 (2.6%) stddev-sans-first:2.40 07:35:49 INFO - PROCESS | 18215 | Values: 90.0 85.0 86.0 89.0 88.0 86.0 90.0 91.0 88.0 92.0 07:35:49 INFO - PROCESS | 18215 | 07:35:49 INFO - PROCESS | 18215 | [#11] stanford-crypto-ccm Cycles:10 Average:142.30 Median:137.50 stddev:17.21 (12.5%) stddev-sans-first:18.23 07:35:49 INFO - PROCESS | 18215 | Values: 145.0 134.0 136.0 134.0 142.0 134.0 136.0 139.0 190.0 133.0 07:35:49 INFO - PROCESS | 18215 | 07:35:49 INFO - PROCESS | 18215 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.70 Median:181.00 stddev:1.42 (0.8%) stddev-sans-first:1.36 07:35:49 INFO - PROCESS | 18215 | Values: 179.0 180.0 179.0 182.0 182.0 180.0 182.0 180.0 183.0 180.0 07:35:49 INFO - PROCESS | 18215 | 07:35:49 INFO - PROCESS | 18215 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:1.70 (2.5%) stddev-sans-first:1.80 07:35:49 INFO - PROCESS | 18215 | Values: 69.0 71.0 69.0 71.0 72.0 70.0 67.0 68.0 69.0 67.0 07:35:49 INFO - PROCESS | 18215 | -------- Summary: end -------- 07:35:49 INFO - PROCESS | 18215 | 07:35:51 INFO - TEST-INFO | 18215: exit 0 07:35:51 INFO - TEST-OK | kraken | took 64197ms 07:35:51 INFO - SUITE-END | took 1183s 07:35:51 INFO - Completed test suite (00:19:43) 07:35:51 INFO - javascript benchmark 07:35:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6196.92472717255, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2588.728183540728, 2591.688997320322, 2597.0780372967597, 2614.4640348728512, 2625.6061590761383, 4538.909221815562, 4674.48580656128, 4686.133065382903, 4690.085433340496, 4732.90534189316, 4611.907761844761, 4630.722156670602, 4673.205555055641, 4700.647451441138, 4746.62027037837, 4305.6124948754605, 4365.890852728683, 4373.693841431101, 4384.18892504886, 4421.20418324703, 4303.182395344875, 4338.392625032482, 4348.652107831366, 4438.312061630452, 4455.443069616298, 4363.476382834048, 4387.056782791683, 4409.713368631044, 4425.513193548707, 4431.911361772763, 4213.894652633678, 4238.788060596958, 4254.638355739766, 4267.082577245876, 4270.274053410928, 4211.663066954637, 4227.8097485613225, 4242.4272723182285, 4279.807408666617, 4316.287812510932, 4579.771011449414, 4628.375169352128, 4643.094596553673, 4649.953500464986, 4659.0, 4874.731889746063, 4903.730294833818, 4943.134951383494, 4996.4254110777, 5037.949620503785, 5106.617003724736, 5107.233914912756, 5111.744412779346, 5120.641555091145, 5163.0, 4779.044191161747, 4787.976060119747, 4794.544518270759, 4795.664303498722, 4833.9999999999645, 4977.751112444364, 5040.36995375578, 5041.269015992661, 5202.557782588447, 5258.2112683097075, 4807.206810876236, 4856.1016212000895, 4859.246816743411, 4868.9269660955115, 4876.29293752411, 4899.093667671492, 4941.851744447672, 4954.355933728664, 4959.70241785494, 4960.280759289955, 4923.729194894244, 4926.48271931442, 4964.255361695775, 4986.650934434555, 5056.772445239973, 4960.429550601655, 5009.298698182258, 5011.173156429221, 5020.970701006285, 5056.898862022739, 4237.919330570747, 4242.109157076987, 4244.10873716523, 4252.4259225004225, 4284.721493102938, 3592.946105808415, 3634.890953271406, 3638.599754027055, 3657.74395792292, 3674.6325367463573, 4162.250794856895, 4171.49942006955, 4178.101708132766, 4204.957950420457, 4225.239456897726, 4953.678010929278, 4995.975020124876, 5014.749262536859, 5040.747962601855, 5076.593872490192, 4048.6356227939627, 4076.30702780528, 4143.56492568282, 4186.330187170038, 4229.069604686964, 4456.197884380843, 4482.596566309048, 4498.392716983165, 4510.864674059783, 4514.7291162530355, 4746.715197088186, 4747.240441529339, 4747.359106520576, 4758.88102797419, 4783.210770222944, 4810.5670489656095, 5062.620303477328, 5065.974670126626, 5070.797168113381, 5100.030994111107, 4615.30770384445, 4697.882552936067, 4736.242201247784, 4754.049190162051, 4807.399075115611, 4784.712917224978, 4978.103941290602, 4979.950200498093, 4982.8754281143265, 5007.449180590205, 4865.0756356292195, 4886.877828054327, 4934.481879402754, 4941.876453088702, 4968.552830245295, 4543.091381723602, 4593.747343895984, 4694.2723877799, 4703.0, 4743.359646447823, 4619.191641462798, 4620.468646105741, 4646.094011667692, 4674.368960190331, 4678.228092364721, 4544.091181763727, 4567.497575266651, 4570.38299829532, 4601.4248218972625, 4656.9301460477445, 4581.404417425713, 4694.0, 4694.765261736968, 4709.916719154545, 4749.9287510688055, 4484.946037681077, 4553.681242313006, 4617.076584683144, 4631.235846085358, 4665.743384113906], "value": 4552.234324473023, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.3650188025309, 531.9122344813106, 536.3510152715214, 547.2256756689285, 557.4091463049168, 37627.81186094069, 39848.20303593927, 39898.99999999996, 43239.56760432395, 43333.0, 40087.0, 40801.0, 40815.0, 40870.59129408705, 40872.0, 7517.736879209242, 7761.22387761225, 7767.145613982458, 7780.6109694515335, 9543.236541076698, 9438.103380178907, 9691.563879625433, 9712.320137590372, 9731.318807683465, 9732.805343893118, 9702.320837541374, 9718.271129665269, 9767.413955162712, 9773.413595184276, 9776.120149186572, 9702.22382209425, 9741.172000379976, 9751.609935602568, 9758.512074396253, 9774.804503909882, 9475.90524094764, 9597.616095356178, 9613.90386096137, 9614.423134611945, 9615.711528654081, 35101.47347789785, 35254.47118293228, 35342.0, 35353.46969795455, 35402.0, 3576.088097535138, 3635.563732352108, 3652.7077833773233, 3653.8173091345325, 3669.6238910408597, 25892.611610825854, 26374.47251054968, 26480.86759566209, 26524.867375662998, 26798.33004174892, 3417.726581873444, 3438.9312213755584, 3558.3417067842533, 3604.8377822998027, 3610.4764809102535, 237586.0, 238955.0, 239424.0, 239489.0, 240160.79919600463, 47426.52573474221, 47455.28817067678, 47764.28353574699, 47816.7609161952, 47851.52148478471, 49890.0, 49941.75029124904, 50119.24821127686, 50155.498445015815, 50261.24608130881, 12085.697857553632, 12378.319192444322, 12397.442115104843, 12411.379431028594, 12418.316992565495, 8906.287497000354, 8957.14907083826, 9179.0, 9206.125418085272, 9483.525823708787, 16208.432704855273, 16217.675646487005, 16279.674406511804, 16380.672386552202, 16441.0, 6356.792209480184, 6442.06590044441, 6559.0, 6757.155355580552, 6799.966000169968, 792.7463211772293, 802.181774589915, 812.6789917982483, 812.7114874219685, 850.0606829453365, 27197.45605087887, 28284.575731364046, 28312.292192694935, 28665.426691466055, 28738.425231495254, 895.0646574329841, 951.9476428796482, 955.9713208603753, 956.9521523923776, 983.7098056073332, 12631.621051368473, 13207.735845283041, 13275.269860157785, 13355.465781368637, 13430.529931452353, 354409.0, 354744.0, 356439.0, 357734.958552904, 358381.0, 43999.820017098325, 44554.0, 44567.331490027675, 44627.33059004117, 44715.10569788586, 1195.1932445599186, 1232.8458942632171, 1238.6222202228407, 1241.6026871401245, 1245.1346314311465, 22949.770502294763, 23339.53320933606, 23882.522349552564, 24059.0, 24491.38771530726, 37297.81351093336, 37925.431118533794, 37955.43066853944, 37963.15276354229, 37969.81015095017, 330134.0, 332465.0, 332849.0, 333275.0, 333365.0, 23873.16443924454, 24358.634620480352, 24551.263462096165, 24660.38349041288, 26116.216513504627, 38108.23783524369, 38349.808250959686, 38533.22933541257, 38777.61222387853, 39667.0, 32299.0, 32433.675663243066, 32590.348193035534, 32672.673273267916, 34124.488132677536, 31746.206344841565, 31824.84087579547, 32833.83583082165, 32939.0, 33681.15797105092, 31443.0, 32255.838720806245, 32311.192220194684, 32362.0, 32587.0, 28581.28546786347, 28816.279593010342, 29418.264543386587, 29954.85022574873, 29992.0, 22765.430864227863, 23023.07907683674, 23112.884435577715, 23283.301500955, 23382.76617233806], "value": 17000.85981577228, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.9659830615244, 381.29270203772006, 383.2371092972328, 400.1057636183132, 402.0391264876945, 17511.824881751178, 18175.81824181758, 18348.54128646783, 18585.721214181798, 18730.812691873096, 17868.0, 18003.0, 18225.088745562734, 18379.172937217823, 18413.17140728667, 5110.616703747224, 5290.6825590464505, 5299.920501192485, 5325.547328477084, 5335.306410166673, 5153.6392452528335, 5375.596830237748, 5402.6758394496455, 5492.670439773627, 5494.945050549503, 5400.918986215191, 5495.917561236584, 5501.559875209973, 5515.586331025169, 5517.503424691777, 5448.700321482317, 5492.752826122834, 5515.531179849718, 5522.502974732293, 5538.3077115360375, 5316.229146773696, 5406.432324605899, 5413.485718856702, 5416.187571864212, 5437.945620543823, 11871.46578403974, 11977.520899164023, 11984.280943143352, 11990.280583165038, 12005.459754311078, 2081.989590052055, 2128.978710212909, 2205.2391924786084, 2249.347689170139, 2263.739669937962, 9254.953725231331, 9511.857322140173, 10168.084872361524, 10518.737031574195, 14082.929585352007, 1739.7564340992271, 1743.5728246579542, 1750.8511776499013, 1769.8230176982327, 1772.8315809998157, 66416.66791666059, 67932.0, 75697.24302756957, 76103.0, 76466.23533764647, 9499.477528735986, 10034.899651003396, 10077.899221007696, 10143.949280253551, 10249.94875025635, 13547.0, 13596.320183990762, 13597.388117534734, 13608.727825443633, 13619.114757540729, 6891.862162756717, 7103.680334384861, 7148.785536433916, 7234.842425211941, 7311.524750891282, 6383.170187875547, 6437.710303036374, 6618.172728408949, 6727.260001399842, 6862.348076932783, 4208.473940757405, 4217.578242175758, 4221.556736542619, 4260.55264197261, 4339.522652508222, 1890.4990177602947, 1891.7162425636266, 1919.7600299962505, 1923.1345894347598, 1944.8541359398102, 800.1118758178417, 818.9017317921888, 818.9590520473953, 828.6685325869701, 846.191886748154, 16690.4158354457, 16763.161841907855, 17443.82556174422, 17478.475645730647, 17770.555736106442, 803.8030682482712, 817.1379194949385, 824.5712229640674, 836.2014276366056, 843.6119385082931, 9114.680986165453, 9409.576569054409, 9668.274879384075, 9721.854172187423, 9789.237937171378, 523835.0, 532974.0, 537597.0, 541545.0, 542274.0, 67906.66046669833, 80713.59643201747, 88081.25488789682, 90336.548317258, 93619.53190234005, 927.2628260532892, 943.061653654618, 967.1005964453126, 970.5292932927524, 971.1065819446127, 14732.0, 14797.482088126864, 14997.850021499646, 15169.469068582546, 15180.848191517944, 35499.645003550664, 36088.4586731194, 37750.0, 41992.95017624584, 42091.579084208766, 52177.47822521726, 54767.72616136894, 54777.0, 54805.45194548003, 56228.0, 5229.712365819764, 5584.636998595079, 7507.962460187882, 7532.472726909064, 8035.517868927883, 9217.86173207389, 12062.638120856389, 12189.390530473618, 12263.877361226274, 12264.816027759412, 10517.474126293502, 10720.67837964831, 10798.460076996276, 11066.0, 11196.94401527987, 10450.163986881184, 10492.213084018882, 10646.520906559379, 10710.357378557312, 11018.228723989243, 10186.286959913032, 10400.27198096126, 10518.631847885288, 10595.94702026485, 10612.575496980344, 7564.962175189089, 7669.463137580316, 7719.459637825298, 7802.219778022152, 7867.527948323119, 8237.711680091408, 9960.651377201762, 10322.916093810041, 10450.529726162189, 10496.317739346918], "value": 8302.75223877334, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.1354099523817, 1300.947962081517, 1314.2180402660426, 1320.5444121777982, 1326.542342891702, 5739.626924249921, 5921.0, 6202.410770976756, 6627.304133066031, 6634.834129146774, 6388.105665206875, 6571.441427478658, 6578.375054369827, 6683.966580167104, 6719.160104986877, 2072.202202152175, 2107.7576078750985, 2109.1457959526338, 2109.2828438330966, 2109.704641350212, 1993.9700904486444, 2072.8218982162007, 2091.7699053104225, 2105.452582328598, 2109.704641350212, 2058.8147066763986, 2090.216168936649, 2099.6745504446835, 2103.6528972719484, 2108.1356643776053, 2005.3983804858485, 2011.3362590345298, 2038.347728726808, 2051.887146206958, 2056.033664177834, 2037.0833125093768, 2054.5069183396026, 2071.332577275293, 2077.1587507059667, 2081.417203183096, 6637.369449902251, 6696.096027036385, 6755.49333799967, 6763.425108865752, 6769.0, 4139.441175441337, 4270.039241170743, 4280.807363668611, 4282.400463935051, 4308.3968244445805, 2611.7518835710575, 2828.8302701837956, 2881.971180288191, 2884.9855750721113, 2900.1154647832404, 1118.5637601335486, 1119.0376276402287, 1143.7712457508449, 1147.6958605969426, 1208.1301462946665, 8449.155084491564, 8449.662013519452, 8468.534230617375, 8484.618192181366, 8502.617382217815, 3550.183457804719, 3713.814309284525, 3731.8244752902747, 3757.3800322946954, 3788.1855401088897, 7009.088818453569, 7016.508844380946, 7024.894626580605, 7035.085438893014, 7044.6125463099, 4143.70994030421, 4183.0, 4184.7070705050355, 4186.246475634415, 4232.132412855357, 3824.521934758155, 3832.2335532892976, 3904.7852368120025, 3913.434626149506, 3930.6265904739003, 3007.5338322560037, 3027.2885871820104, 3095.520194369876, 3100.488419410817, 3204.455242608762, 857.9485230886166, 878.7715194049465, 906.1663269791808, 932.5477143585356, 942.8821397325335, 748.8914107454389, 760.2853317881174, 773.2769860180749, 777.2033665492802, 777.475204237149, 4328.783560821947, 4347.5217726050105, 4356.934645980313, 4406.9779651101535, 4427.048184640318, 836.4019725896013, 850.4812064640564, 855.4225897519274, 876.9473831570126, 884.5356188001351, 2939.6619388770137, 3044.6194225721783, 3056.7401770849283, 3072.2472994116583, 3137.105924811418, 7327.487075904635, 7677.539347639159, 7690.692372305157, 7720.575368354682, 7843.882341764878, 7837.960810195913, 7841.098273698483, 7855.646495907584, 7861.685532578633, 7899.723509677134, 6181.7527298908435, 6273.404026617464, 6276.435120839146, 6281.214848143982, 6298.1812364392335, 4563.087382523442, 4625.352450656978, 4643.907121857476, 4701.459332176843, 4701.882452938704, 7142.214356420685, 7209.4592905533345, 7214.639268036683, 7323.63381830917, 7372.557646541225, 7298.416126709957, 7303.488755787044, 7338.926610733824, 7374.852502950018, 7401.851962960818, 5706.4864162225595, 5754.798582049608, 5793.15999180125, 5799.217105690678, 5799.739011744566, 6023.939760602513, 6041.314927003709, 6061.515078793598, 6100.298465676504, 6127.601705889103, 5739.110437882135, 5801.129830525455, 5824.301083869963, 5828.708564571839, 5895.970520147372, 5749.051406517878, 5790.826275211751, 5831.0378787499585, 5838.708064596668, 5910.52715782745, 5000.699958002531, 5100.362454693163, 5116.283720279238, 5121.231815227746, 5122.948770512397, 3881.9223615528094, 3902.9609703902597, 3948.1314110895555, 4010.6791456682813, 4070.8805078602436, 4019.618136277049, 4035.6569691576547, 4062.2484840304637, 4118.19695159453, 4126.5667104953545], "value": 3636.8183085826768, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.60370573840083, 347.93911065563526, 356.33543441481646, 357.09298382109444, 358.35853821659214, 4808.591269742076, 4922.926156107656, 4984.401871775388, 5027.924581131281, 5028.0, 4881.24340727187, 4898.461169271377, 4928.5564299213065, 4934.185859333205, 4935.284383764352, 3837.980810095946, 3839.6544311011935, 3844.308024555579, 3866.4780254665543, 3867.38121900496, 3746.3069332173636, 3838.596947320533, 3860.652541271285, 3867.2265546890594, 3882.388808644409, 3768.792716400597, 3772.6793222575975, 3804.896579991799, 3807.505024346845, 3817.7518461300065, 3773.1510410157634, 3785.3754130568423, 3790.166163444038, 3802.4106263529197, 3822.789746563938, 3330.20075181957, 3342.9636812588174, 3344.5986481622363, 3347.610741542257, 3349.5213541979006, 4697.436307643071, 4772.832950846704, 4838.983813399191, 4884.511548845123, 4900.505345869544, 4328.913421731548, 4330.848420305306, 4341.39220509129, 4353.760543170124, 4366.8253269869165, 5141.15170996785, 5191.039657663345, 5211.088059589557, 5215.191645294985, 5241.161414173752, 3651.707863370924, 3656.287024030315, 3690.741648084635, 3694.5751238607636, 3694.612065733113, 5148.716820574867, 5387.380451248117, 5418.160185171305, 5434.945650543523, 5448.863778405532, 3672.7429079964145, 3697.8335974880656, 3720.4605332226674, 3727.0, 3728.8508459661853, 3760.360738674432, 3775.6601905828607, 3775.9433608495897, 3781.4138808484727, 3794.317022935898, 4116.794160291974, 4281.91436171281, 4308.332208507686, 4357.520672725997, 4365.410669559569, 5129.153689641242, 5150.613703972217, 5151.407588127413, 5160.200168973815, 5195.558377537876, 1226.5400474821943, 1254.0, 1254.956076537317, 1273.5096987659817, 1285.1582213650074, 835.774340927946, 861.6940985950023, 864.8097418567905, 870.3907264914585, 879.7448739865496, 4198.685098617616, 4200.537940826506, 4213.0, 4228.112096459778, 4230.323148296257, 5063.670861393997, 5090.669106508065, 5111.667741596784, 5114.335136432314, 5122.410922743858, 4163.354680024601, 4216.789160541961, 4218.578142185818, 4220.530989371191, 4245.511766146933, 2599.7261341942312, 2674.473021278297, 2682.9463410732064, 2689.8117131800586, 2723.2919440945498, 4790.802299425144, 4793.376861008116, 4802.183628783116, 4806.49531799163, 4816.242071643825, 5235.8481134150425, 5239.371275446894, 5246.449122842123, 5253.579713622901, 5292.153255479105, 4622.86131416058, 4920.6309526785635, 4967.950320496893, 4975.9847261859, 4994.3507344045765, 5257.237700533477, 5282.762275697526, 5292.126799078109, 5307.54885834693, 5307.761150748149, 4951.257311403318, 5244.475552444725, 5251.159814429673, 5262.605304602093, 5268.604854635994, 4937.728424936519, 4963.205887058053, 4968.22992436173, 4989.151844186569, 4996.127226844506, 3729.606058486764, 3738.981305093457, 3749.6625303722794, 3780.4707340972836, 3781.0, 4840.75796210181, 5358.839234822962, 5369.926014796978, 5370.785168593213, 5374.435684253253, 4952.4057113146655, 4969.552740253394, 4971.975140124277, 4982.352294201731, 4993.0, 4969.950300497093, 4977.651564390603, 4983.5763960063805, 4994.775235114501, 5007.298978143136, 4761.214399624023, 4857.9028419432125, 4870.586000190024, 4917.336159618406, 4921.188003979303, 5000.424951130666, 5004.347695721273, 5025.346704928336, 5028.723420211923, 5043.789490522322, 4905.509449055208, 4909.926351104665, 4913.0, 4933.802647894044, 4959.429665588504], "value": 3838.2008791579983, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [678.525032477266, 682.7132604306191, 739.71890681541, 772.2856357868972, 784.8626490364187, 12635.178713383624, 13475.932620336896, 13587.864121358783, 13616.659583510418, 13617.863821361783, 13012.089153759242, 13040.73918521629, 13053.151545149558, 13062.934685326583, 13082.0, 647.4820143884897, 681.6591704147926, 772.6793380746983, 788.562347896917, 808.0828259924969, 801.8797180422924, 816.0, 817.2236375443352, 818.5048045932215, 819.1562690428868, 865.6061492021115, 866.8093019535692, 869.3957699398889, 870.4342177584557, 871.0375035585681, 862.516990485324, 862.7454900804278, 862.7886167888876, 863.0420233540765, 863.1109956744563, 631.7946667333135, 632.6457183976942, 634.3022675057446, 638.157631925858, 638.6104476269472, 13971.441142354293, 14126.293685315795, 14221.715565688732, 14408.351624176938, 14431.0, 13508.0, 13771.724565508634, 14323.35544900482, 14391.928040359731, 14588.70822583553, 11183.496742646601, 11275.718107047389, 11279.097672186206, 11282.774344513064, 11410.258333208314, 3274.8690052397874, 3284.934301313984, 3293.2096296888813, 3307.6526964668847, 3425.0, 66365.0, 66448.0, 67371.0, 68329.31670683328, 68464.6576767118, 10552.366857988545, 10556.947215263874, 10755.462226888625, 10760.838587421194, 10935.179861510418, 21361.0, 21384.251551195946, 21438.356849294545, 21441.249556265455, 21461.89269053676, 6780.118584583973, 6855.457522057497, 7042.084529011196, 7133.607651579109, 7138.643067846587, 3712.230072742999, 3825.5218097737784, 3830.291396091732, 3858.2090671412293, 3861.2084522672785, 2908.6218791557385, 2980.1357606294364, 2984.686607906182, 2992.5511173324176, 3008.744256738202, 483.68560435717063, 492.1633223519959, 494.7575687912969, 496.74417674897455, 502.02105893507803, 613.5582380685898, 632.6109442692803, 645.3578689204178, 647.2233320015999, 648.9091527186198, 8399.790005249795, 8624.353173512012, 8681.826363472821, 8836.734897953073, 8960.551972401354, 624.7438550194398, 635.5646382228189, 645.7578408096964, 654.7217432591129, 657.7763560389491, 3966.6628336591134, 4021.718479706451, 4031.0930040741187, 4076.144009757984, 4098.446709694213, 64162.67918660377, 64339.0, 65514.0, 66324.0, 69246.307536925, 57163.0, 57330.713346433, 57585.712071439375, 58203.0, 58761.0, 53215.46784532105, 53303.46696533063, 53531.46468535343, 53724.462755372726, 54890.451095489334, 7614.771556853303, 7820.687172513036, 7910.52536847791, 8080.474769139987, 8089.919100809152, 35977.64022359848, 36444.635553644126, 37247.81376093102, 38024.80987595044, 38464.80767596144, 43132.137357253305, 45178.322325165806, 45567.54432455633, 46795.532044679116, 47372.2894156581, 9804.313698041355, 9878.259130565093, 9992.950035249778, 10005.099541041342, 10120.392776433437, 10645.574177032831, 10697.304675196086, 10811.513481893491, 11251.49368278413, 11276.32342059479, 10256.48717564104, 10519.105876000625, 10700.946495267473, 10824.296420732628, 10843.349399036084, 10632.734181645521, 10918.290311129751, 11124.777504450027, 11128.721781955515, 11135.610253641084, 9900.356476828983, 10191.796164076824, 10275.280730349103, 10567.735806604589, 10666.946665266623, 8552.914470855212, 8595.484270943763, 8674.349423793115, 8716.302695784196, 8828.911710882809, 8224.0, 8351.707690230813, 8464.661413543636, 8478.236958673502, 8701.52141632191], "value": 6313.00802580023, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1572.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 115.0, 116.0, 116.0, 115.0, 115.0, 116.0, 116.0, 115.0, 116.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 123.0, 131.0, 178.0, 130.0, 129.0, 127.0, 128.0, 147.0, 126.0], "value": 137.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 166.0, 174.0, 164.0, 163.0, 162.0, 164.0, 163.0, 162.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 77.0, 76.0, 109.0, 78.0, 77.0, 78.0, 77.0, 96.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 112.0, 86.0, 86.0, 85.0, 96.0, 86.0, 86.0, 112.0], "value": 91.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 119.0, 120.0, 118.0, 118.0, 118.0, 119.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 154.0, 151.0, 153.0, 152.0, 151.0, 151.0, 152.0, 152.0, 151.0], "value": 151.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 65.0, 64.0, 65.0, 66.0, 67.0, 65.0, 66.0, 66.0, 65.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 67.0, 68.0, 68.0, 72.0, 68.0, 68.0, 68.0, 67.0], "value": 68.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 85.0, 86.0, 89.0, 88.0, 86.0, 90.0, 91.0, 88.0, 92.0], "value": 88.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 134.0, 136.0, 134.0, 142.0, 134.0, 136.0, 139.0, 190.0, 133.0], "value": 142.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 180.0, 179.0, 182.0, 182.0, 180.0, 182.0, 180.0, 183.0, 180.0], "value": 180.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 69.0, 71.0, 72.0, 70.0, 67.0, 68.0, 69.0, 67.0], "value": 69.3, "unit": "score"}]}]} 07:35:51 INFO - Return code: 0 07:35:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:35:51 ERROR - # TBPL SUCCESS # 07:35:51 INFO - Running post-action listener: _resource_record_post_action 07:35:51 INFO - [mozharness: 2017-01-07 15:35:51.716472Z] Finished run-tests step (success) 07:35:51 INFO - Running post-run listener: _resource_record_post_run 07:35:51 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 2273280; Write bytes: 413106176; Read time: 636; Write time: 339396 07:35:51 INFO - TinderboxPrint: CPU usage
13.5% 07:35:51 INFO - TinderboxPrint: I/O read bytes / time
2,273,280 / 636 07:35:51 INFO - TinderboxPrint: I/O write bytes / time
413,106,176 / 339,396 07:35:51 INFO - TinderboxPrint: CPU idle
8,282.4 (86.5%) 07:35:51 INFO - TinderboxPrint: CPU user
1,232.2 (12.9%) 07:35:51 INFO - TinderboxPrint: Swap in / out
0 / 0 07:35:51 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99483648; Read time: 0; Write time: 130028 07:35:51 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 2273280; Write bytes: 296275968; Read time: 636; Write time: 204456 07:35:52 INFO - Running post-run listener: _upload_blobber_files 07:35:52 INFO - Blob upload gear active. 07:35:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:35:52 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:35:52 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:35:52 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:35:52 INFO - (blobuploader) - INFO - Open directory for files ... 07:35:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:35:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:35:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:56 INFO - (blobuploader) - INFO - Done attempting. 07:35:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 07:35:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 07:35:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:57 INFO - (blobuploader) - INFO - Done attempting. 07:35:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 07:35:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 07:35:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:58 INFO - (blobuploader) - INFO - Done attempting. 07:35:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:35:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:35:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:35:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:35:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:35:58 INFO - (blobuploader) - INFO - Done attempting. 07:35:58 INFO - (blobuploader) - INFO - Iteration through files over. 07:35:58 INFO - Return code: 0 07:35:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:35:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:35:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5dbb361bff667768aec807c0b16dd397c7ca0f2e99cd31955b9d0885fd5a53a58d13170a03364d38508363800915cdc2c39affc4a83043ba855f2d647327f7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/01ce26556138600608e161fbc630131e6117785ee17c3d29453f2233e1b9dcf1320c579f9d54e3ac3d3017c59e26c92b1abb9435ebecaa8963cab755f7337444", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dd9c9a49765540d5d95f66d988b52d7828837aeaaf361c7284e24f78af4ed4ed5444655497d2f41f4fb5406a915a68893e8c0fe4a80f1ac068f5b9feb04eed1b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cbc1618c9e968b6ce3a01f3fcab3ee769b62dbed616412056d379fd86e7e6030bb4348e738fd99ec2c410074b5861cbed5d2808cc7a8f6a7734b7eae0e50d2c1"} 07:35:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:35:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:35:58 INFO - Contents: 07:35:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5dbb361bff667768aec807c0b16dd397c7ca0f2e99cd31955b9d0885fd5a53a58d13170a03364d38508363800915cdc2c39affc4a83043ba855f2d647327f7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/01ce26556138600608e161fbc630131e6117785ee17c3d29453f2233e1b9dcf1320c579f9d54e3ac3d3017c59e26c92b1abb9435ebecaa8963cab755f7337444", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dd9c9a49765540d5d95f66d988b52d7828837aeaaf361c7284e24f78af4ed4ed5444655497d2f41f4fb5406a915a68893e8c0fe4a80f1ac068f5b9feb04eed1b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cbc1618c9e968b6ce3a01f3fcab3ee769b62dbed616412056d379fd86e7e6030bb4348e738fd99ec2c410074b5861cbed5d2808cc7a8f6a7734b7eae0e50d2c1"} 07:35:58 INFO - Running post-run listener: copy_logs_to_upload_dir 07:35:58 INFO - Copying logs to upload dir... 07:35:58 INFO - mkdir: /builds/slave/test/build/upload/logs 07:35:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.405395 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2017-01-07 07:35:58.652335) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-07 07:35:58.657027) ========= 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=3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964 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/f5dbb361bff667768aec807c0b16dd397c7ca0f2e99cd31955b9d0885fd5a53a58d13170a03364d38508363800915cdc2c39affc4a83043ba855f2d647327f7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/01ce26556138600608e161fbc630131e6117785ee17c3d29453f2233e1b9dcf1320c579f9d54e3ac3d3017c59e26c92b1abb9435ebecaa8963cab755f7337444", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dd9c9a49765540d5d95f66d988b52d7828837aeaaf361c7284e24f78af4ed4ed5444655497d2f41f4fb5406a915a68893e8c0fe4a80f1ac068f5b9feb04eed1b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cbc1618c9e968b6ce3a01f3fcab3ee769b62dbed616412056d379fd86e7e6030bb4348e738fd99ec2c410074b5861cbed5d2808cc7a8f6a7734b7eae0e50d2c1"} build_url:https://queue.taskcluster.net/v1/task/btn9mzhtRzujZVq9U-TocA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011259 build_url: 'https://queue.taskcluster.net/v1/task/btn9mzhtRzujZVq9U-TocA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f5dbb361bff667768aec807c0b16dd397c7ca0f2e99cd31955b9d0885fd5a53a58d13170a03364d38508363800915cdc2c39affc4a83043ba855f2d647327f7e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/01ce26556138600608e161fbc630131e6117785ee17c3d29453f2233e1b9dcf1320c579f9d54e3ac3d3017c59e26c92b1abb9435ebecaa8963cab755f7337444", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/dd9c9a49765540d5d95f66d988b52d7828837aeaaf361c7284e24f78af4ed4ed5444655497d2f41f4fb5406a915a68893e8c0fe4a80f1ac068f5b9feb04eed1b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/cbc1618c9e968b6ce3a01f3fcab3ee769b62dbed616412056d379fd86e7e6030bb4348e738fd99ec2c410074b5861cbed5d2808cc7a8f6a7734b7eae0e50d2c1"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-07 07:35:58.682264) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 07:35:58.682583) ========= 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=3836458cccd887f2d2de3cf1000001de-1483797371.582694-322388964 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004500 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 07:35:58.765355) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-07 07:35:58.765679) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-07 07:35:58.765990) ========= ========= Total master_lag: 0.17 =========