builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs slave: talos-linux64-ix-048 starttime: 1493891974.27 results: success (0) revision: 33b92d9c40562dab3d7b602368c75619f1d793f7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 02:59:34.276271) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 02:59:34.276878) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 02:59:34.277151) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 02:59:34.294361) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 02:59:34.294643) ========= 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=fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-04 02:59:35-- 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% 94.0M=0s 2017-05-04 02:59:35 (94.0 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.076834 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 02:59:34.385519) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 02:59:34.385815) ========= 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=fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016354 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 02:59:34.437992) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 02:59:34.438317) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 33b92d9c40562dab3d7b602368c75619f1d793f7 --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 33b92d9c40562dab3d7b602368c75619f1d793f7 --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=fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-04 02:59:35,563 truncating revision to first 12 chars 2017-05-04 02:59:35,563 Setting DEBUG logging. 2017-05-04 02:59:35,563 attempt 1/10 2017-05-04 02:59:35,563 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/33b92d9c4056?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-04 02:59:36,419 unpacking tar archive at: mozilla-central-33b92d9c4056/testing/mozharness/ program finished with exit code 0 elapsedTime=1.541770 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 02:59:36.000602) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 02:59:36.000920) ========= script_repo_revision: 33b92d9c40562dab3d7b602368c75619f1d793f7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 02:59:36.001286) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 02:59:36.001561) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 02:59:36.012988) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-05-04 02:59:36.013263) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 02:59:37 INFO - MultiFileLogger online at 20170504 02:59:37 in /builds/slave/test 02:59:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 02:59:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:59:37 INFO - {'append_to_log': False, 02:59:37 INFO - 'base_work_dir': '/builds/slave/test', 02:59:37 INFO - 'blob_upload_branch': 'Firefox', 02:59:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:59:37 INFO - 'branch': 'Firefox', 02:59:37 INFO - 'buildbot_json_path': 'buildprops.json', 02:59:37 INFO - 'config_files': ('talos/linux_config.py',), 02:59:37 INFO - 'default_actions': ('clobber', 02:59:37 INFO - 'read-buildbot-config', 02:59:37 INFO - 'download-and-extract', 02:59:37 INFO - 'populate-webroot', 02:59:37 INFO - 'create-virtualenv', 02:59:37 INFO - 'install', 02:59:37 INFO - 'run-tests'), 02:59:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:59:37 INFO - 'download_minidump_stackwalk': True, 02:59:37 INFO - 'download_symbols': 'ondemand', 02:59:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:59:37 INFO - 'tooltool.py': '/tools/tooltool.py', 02:59:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:59:37 INFO - '/tools/misc-python/virtualenv.py')}, 02:59:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:59:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:59:37 INFO - 'gecko_profile': False, 02:59:37 INFO - 'gecko_profile_interval': 0, 02:59:37 INFO - 'installer_path': 'installer.exe', 02:59:37 INFO - 'log_level': 'info', 02:59:37 INFO - 'log_name': 'talos', 02:59:37 INFO - 'log_to_console': True, 02:59:37 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 02:59:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 02:59:37 INFO - 'opt_config_files': (), 02:59:37 INFO - 'pip_index': False, 02:59:37 INFO - 'suite': 'dromaeojs', 02:59:37 INFO - 'system_bits': '32', 02:59:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:59:37 INFO - 'title': 'talos-linux64-ix-048', 02:59:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:59:37 INFO - 'use_talos_json': True, 02:59:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:59:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:59:37 INFO - 'work_dir': 'build'} 02:59:37 INFO - [mozharness: 2017-05-04 09:59:37.232527Z] Running clobber step. 02:59:37 INFO - Running pre-action listener: _resource_record_pre_action 02:59:37 INFO - Running main action method: clobber 02:59:37 INFO - rmtree: /builds/slave/test/build 02:59:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:59:38 INFO - Running post-action listener: _resource_record_post_action 02:59:38 INFO - [mozharness: 2017-05-04 09:59:38.170943Z] Finished clobber step (success) 02:59:38 INFO - [mozharness: 2017-05-04 09:59:38.171043Z] Running read-buildbot-config step. 02:59:38 INFO - Running pre-action listener: _resource_record_pre_action 02:59:38 INFO - Running main action method: read_buildbot_config 02:59:38 INFO - Using buildbot properties: 02:59:38 INFO - { 02:59:38 INFO - "project": "", 02:59:38 INFO - "product": "firefox", 02:59:38 INFO - "who": "cbook@mozilla.com", 02:59:38 INFO - "installer_path": "public/build/target.tar.bz2", 02:59:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs", 02:59:38 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 02:59:38 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs", 02:59:38 INFO - "stage_platform": "linux64-stylo", 02:59:38 INFO - "basedir": "/builds/slave/test", 02:59:38 INFO - "buildnumber": 77, 02:59:38 INFO - "platform": "ubuntu64_hw_stylo", 02:59:38 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 02:59:38 INFO - "slavebuilddir": "test", 02:59:38 INFO - "taskId": "ecpBHRNhQq2ggOa-G2MyHg", 02:59:38 INFO - "branch": "mozilla-central", 02:59:38 INFO - "script_repo_revision": "production", 02:59:38 INFO - "revision": "33b92d9c40562dab3d7b602368c75619f1d793f7", 02:59:38 INFO - "slavename": "talos-linux64-ix-048", 02:59:38 INFO - "repo_path": "mozilla-central" 02:59:38 INFO - } 02:59:38 INFO - Finding installer, test and symbols from parent task. 02:59:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ecpBHRNhQq2ggOa-G2MyHg'}, attempt #1 02:59:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ecpBHRNhQq2ggOa-G2MyHg'}, attempt #1 02:59:39 INFO - Task dependencies: Z-TFwTHbQCifRD3657r75g 02:59:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g'}, attempt #1 02:59:39 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g/artifacts/public/build/target.tar.bz2 02:59:39 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g/artifacts/public/build/test_packages.json 02:59:39 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g/artifacts/public/build/target.crashreporter-symbols.zip 02:59:39 INFO - Running post-action listener: _resource_record_post_action 02:59:39 INFO - [mozharness: 2017-05-04 09:59:39.524692Z] Finished read-buildbot-config step (success) 02:59:39 INFO - [mozharness: 2017-05-04 09:59:39.524909Z] Running download-and-extract step. 02:59:39 INFO - Running pre-action listener: _resource_record_pre_action 02:59:39 INFO - Running main action method: download_and_extract 02:59:39 INFO - mkdir: /builds/slave/test/build/tests 02:59: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')]} 02:59:39 INFO - trying https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g/artifacts/public/build/target.test_packages.json 02:59:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 02:59:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 02:59:40 INFO - Downloaded 986 bytes. 02:59:40 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 02:59:40 INFO - Using the following test package requirements: 02:59:40 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 02:59:40 INFO - u'common': [u'target.common.tests.zip'], 02:59:40 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 02:59:40 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 02:59:40 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 02:59:40 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 02:59:40 INFO - u'mozbase': [u'target.common.tests.zip'], 02:59:40 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 02:59:40 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 02:59:40 INFO - u'web-platform': [u'target.common.tests.zip', 02:59:40 INFO - u'target.web-platform.tests.zip'], 02:59:40 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 02:59:40 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 02:59:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g/artifacts/public/build/target.common.tests.zip 02:59:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:59:40 INFO - Fetch https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g/artifacts/public/build/target.common.tests.zip into memory 02:59:42 INFO - Content-Length response header: 58441533 02:59:42 INFO - Bytes received: 58441533 02:59:52 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 02:59:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g/artifacts/public/build/target.common.tests.zip 02:59:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g/artifacts/public/build/target.common.tests.zip'}, attempt #1 02:59:52 INFO - Fetch https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g/artifacts/public/build/target.common.tests.zip into memory 02:59:53 INFO - Content-Length response header: 58441533 02:59:53 INFO - Bytes received: 58441533 03:00:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g/artifacts/public/build/target.talos.tests.zip 03:00:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g/artifacts/public/build/target.talos.tests.zip'}, attempt #1 03:00:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g/artifacts/public/build/target.talos.tests.zip into memory 03:00:05 INFO - Content-Length response header: 14408809 03:00:05 INFO - Bytes received: 14408809 03:00:05 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')]} 03:00:05 INFO - trying https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g/artifacts/public/build/target.tar.bz2 03:00:05 INFO - Downloading https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 03:00:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 03:00:08 INFO - Downloaded 59866118 bytes. 03:00:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g/artifacts/public/build/target.tar.bz2 03:00:08 INFO - mkdir: /builds/slave/test/properties 03:00:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:00:08 INFO - Writing to file /builds/slave/test/properties/build_url 03:00:08 INFO - Contents: 03:00:08 INFO - build_url:https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g/artifacts/public/build/target.tar.bz2 03:00:08 INFO - Running post-action listener: _resource_record_post_action 03:00:08 INFO - Running post-action listener: set_extra_try_arguments 03:00:08 INFO - [mozharness: 2017-05-04 10:00:08.168837Z] Finished download-and-extract step (success) 03:00:08 INFO - [mozharness: 2017-05-04 10:00:08.168934Z] Running populate-webroot step. 03:00:08 INFO - Running pre-action listener: _resource_record_pre_action 03:00:08 INFO - Running main action method: populate_webroot 03:00:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:00:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:00:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:00:08 INFO - '--tppagecycles', 03:00:08 INFO - '7'], 03:00:08 INFO - 'tests': ['tsvgm']}}, 03:00:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:00:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:00:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:00:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:00:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:00:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:00:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:00:08 INFO - 'talos_options': ['--disable-e10s'], 03:00:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:00:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:00:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:00:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:00:08 INFO - 'talos_options': ['--disable-e10s'], 03:00:08 INFO - 'tests': ['damp', 'tps']}, 03:00:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:00:08 INFO - 'tests': ['damp', 'tps']}, 03:00:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:00:08 INFO - 'tests': ['dromaeo_dom']}, 03:00:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:00:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:00:08 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 03:00:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 03:00:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:00:08 INFO - 'tests': ['a11yr', 03:00:08 INFO - 'ts_paint', 03:00:08 INFO - 'tpaint', 03:00:08 INFO - 'sessionrestore', 03:00:08 INFO - 'sessionrestore_no_auto_restore', 03:00:08 INFO - 'tabpaint']}, 03:00:08 INFO - 'other-e10s': {'tests': ['a11yr', 03:00:08 INFO - 'ts_paint', 03:00:08 INFO - 'tpaint', 03:00:08 INFO - 'sessionrestore', 03:00:08 INFO - 'sessionrestore_no_auto_restore', 03:00:08 INFO - 'tabpaint']}, 03:00:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:00:08 INFO - 'ts_paint', 03:00:08 INFO - 'tpaint', 03:00:08 INFO - 'sessionrestore', 03:00:08 INFO - 'sessionrestore_no_auto_restore', 03:00:08 INFO - 'tabpaint']}, 03:00:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:00:08 INFO - 'ts_paint', 03:00:08 INFO - 'tpaint', 03:00:08 INFO - 'sessionrestore', 03:00:08 INFO - 'sessionrestore_no_auto_restore', 03:00:08 INFO - 'tabpaint']}, 03:00:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:00:08 INFO - 'tests': ['a11yr', 03:00:08 INFO - 'ts_paint', 03:00:08 INFO - 'tpaint', 03:00:08 INFO - 'sessionrestore', 03:00:08 INFO - 'sessionrestore_no_auto_restore', 03:00:08 INFO - 'tabpaint']}, 03:00:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:00:08 INFO - 'tests': ['a11yr', 03:00:08 INFO - 'ts_paint', 03:00:08 INFO - 'tpaint', 03:00:08 INFO - 'sessionrestore', 03:00:08 INFO - 'sessionrestore_no_auto_restore', 03:00:08 INFO - 'tabpaint']}, 03:00:08 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 03:00:08 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 03:00:08 INFO - 'bloom_basic_ref']}, 03:00:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:00:08 INFO - 'tests': ['tsvgx', 03:00:08 INFO - 'tsvgr_opacity', 03:00:08 INFO - 'tart', 03:00:08 INFO - 'tscrollx', 03:00:08 INFO - 'cart', 03:00:08 INFO - 'tsvg_static']}, 03:00:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:00:08 INFO - 'tsvgr_opacity', 03:00:08 INFO - 'tart', 03:00:08 INFO - 'tscrollx', 03:00:08 INFO - 'cart', 03:00:08 INFO - 'tsvg_static']}, 03:00:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:00:08 INFO - 'talos_options': ['--disable-e10s'], 03:00:08 INFO - 'tests': ['tp5o']}, 03:00:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:00:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:00:08 INFO - 'talos_options': ['--disable-e10s', 03:00:08 INFO - '--xperf_path', 03:00:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:00:08 INFO - 'tests': ['tp5n']}, 03:00:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:00:08 INFO - 'talos_options': ['--xperf_path', 03:00:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:00:08 INFO - 'tests': ['tp5n']}}, 03:00:08 INFO - 'talos.zip': {'path': '', 03:00:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:00:08 INFO - Running post-action listener: _resource_record_post_action 03:00:08 INFO - [mozharness: 2017-05-04 10:00:08.182633Z] Finished populate-webroot step (success) 03:00:08 INFO - [mozharness: 2017-05-04 10:00:08.182723Z] Running create-virtualenv step. 03:00:08 INFO - Running pre-action listener: _resource_record_pre_action 03:00:08 INFO - Running main action method: create_virtualenv 03:00:08 INFO - Creating virtualenv /builds/slave/test/build/venv 03:00:08 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 03:00:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:00:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:00:08 INFO - Using real prefix '/usr' 03:00:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:00:08 INFO - Installing distribute.............................................................................................................................................................................................done. 03:00:10 INFO - Installing pip.................done. 03:00:10 INFO - Return code: 0 03:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:00:10 INFO - Reading from file tmpfile_stdout 03:00:10 INFO - Output received: 03:00:10 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) 03:00:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c32a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e93310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e90400>, '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 0x1e913b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e91840>, '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': 'fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150', '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 03:00:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:00:10 INFO - Using env: {'DISPLAY': ':0', 03:00:10 INFO - 'HOME': '/home/cltbld', 03:00:10 INFO - 'LANG': 'en_US.UTF-8', 03:00:10 INFO - 'LANGUAGE': 'en_US:en', 03:00:10 INFO - 'LOGNAME': 'cltbld', 03:00:10 INFO - 'MAIL': '/var/mail/cltbld', 03:00:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:10 INFO - 'MOZ_NO_REMOTE': '1', 03:00:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:10 INFO - 'NO_EM_RESTART': '1', 03:00:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:10 INFO - 'PWD': '/builds/slave/test', 03:00:10 INFO - 'SHELL': '/bin/bash', 03:00:10 INFO - 'SHLVL': '1', 03:00:10 INFO - 'TERM': 'linux', 03:00:10 INFO - 'TMOUT': '86400', 03:00:10 INFO - 'USER': 'cltbld', 03:00:10 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150', 03:00:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:10 INFO - '_': '/tools/buildbot/bin/python'} 03:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:11 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 03:00:11 INFO - Cleaning up... 03:00:11 INFO - Return code: 0 03:00:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:00:11 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')]} 03:00:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:11 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')]} 03:00:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:11 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 0x1bf51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c32a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e93310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e90400>, '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 0x1e913b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e91840>, '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': 'fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150', '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 03:00:11 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 03:00:11 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 03:00:11 INFO - Using env: {'DISPLAY': ':0', 03:00:11 INFO - 'HOME': '/home/cltbld', 03:00:11 INFO - 'LANG': 'en_US.UTF-8', 03:00:11 INFO - 'LANGUAGE': 'en_US:en', 03:00:11 INFO - 'LOGNAME': 'cltbld', 03:00:11 INFO - 'MAIL': '/var/mail/cltbld', 03:00:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:11 INFO - 'MOZ_NO_REMOTE': '1', 03:00:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:11 INFO - 'NO_EM_RESTART': '1', 03:00:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:11 INFO - 'PWD': '/builds/slave/test', 03:00:11 INFO - 'SHELL': '/bin/bash', 03:00:11 INFO - 'SHLVL': '1', 03:00:11 INFO - 'TERM': 'linux', 03:00:11 INFO - 'TMOUT': '86400', 03:00:11 INFO - 'USER': 'cltbld', 03:00:11 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150', 03:00:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:11 INFO - '_': '/tools/buildbot/bin/python'} 03:00:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:11 INFO - Downloading/unpacking psutil>=3.1.1 03:00:11 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 03:00:11 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 03:00:11 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 03:00:11 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 03:00:11 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 03:00:11 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 03:00:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:00:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:12 INFO - Installing collected packages: psutil 03:00:12 INFO - Running setup.py install for psutil 03:00:12 INFO - building 'psutil._psutil_linux' extension 03:00:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:00:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:00:12 INFO - building 'psutil._psutil_posix' extension 03:00:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:00:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:00:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:00:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:00:13 INFO - Successfully installed psutil 03:00:13 INFO - Cleaning up... 03:00:13 INFO - Return code: 0 03:00:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:00:13 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')]} 03:00:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:13 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')]} 03:00:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:13 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 0x1bf51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c32a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e93310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e90400>, '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 0x1e913b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e91840>, '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': 'fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150', '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 03:00:13 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 03:00:13 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 03:00:13 INFO - Using env: {'DISPLAY': ':0', 03:00:13 INFO - 'HOME': '/home/cltbld', 03:00:13 INFO - 'LANG': 'en_US.UTF-8', 03:00:13 INFO - 'LANGUAGE': 'en_US:en', 03:00:13 INFO - 'LOGNAME': 'cltbld', 03:00:13 INFO - 'MAIL': '/var/mail/cltbld', 03:00:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:13 INFO - 'MOZ_NO_REMOTE': '1', 03:00:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:13 INFO - 'NO_EM_RESTART': '1', 03:00:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:13 INFO - 'PWD': '/builds/slave/test', 03:00:13 INFO - 'SHELL': '/bin/bash', 03:00:13 INFO - 'SHLVL': '1', 03:00:13 INFO - 'TERM': 'linux', 03:00:13 INFO - 'TMOUT': '86400', 03:00:13 INFO - 'USER': 'cltbld', 03:00:13 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150', 03:00:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:13 INFO - '_': '/tools/buildbot/bin/python'} 03:00:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:00:13 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 03:00:13 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 03:00:13 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 03:00:13 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 03:00:13 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 03:00:13 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 03:00:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:00:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:00:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:00:14 INFO - Installing collected packages: mozsystemmonitor 03:00:14 INFO - Running setup.py install for mozsystemmonitor 03:00:14 INFO - Successfully installed mozsystemmonitor 03:00:14 INFO - Cleaning up... 03:00:14 INFO - Return code: 0 03:00:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c32a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e93310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e90400>, '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 0x1e913b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e91840>, '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': 'fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150', '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 03:00:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:00:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:00:14 INFO - Using env: {'DISPLAY': ':0', 03:00:14 INFO - 'HOME': '/home/cltbld', 03:00:14 INFO - 'LANG': 'en_US.UTF-8', 03:00:14 INFO - 'LANGUAGE': 'en_US:en', 03:00:14 INFO - 'LOGNAME': 'cltbld', 03:00:14 INFO - 'MAIL': '/var/mail/cltbld', 03:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:14 INFO - 'MOZ_NO_REMOTE': '1', 03:00:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:14 INFO - 'NO_EM_RESTART': '1', 03:00:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:14 INFO - 'PWD': '/builds/slave/test', 03:00:14 INFO - 'SHELL': '/bin/bash', 03:00:14 INFO - 'SHLVL': '1', 03:00:14 INFO - 'TERM': 'linux', 03:00:14 INFO - 'TMOUT': '86400', 03:00:14 INFO - 'USER': 'cltbld', 03:00:14 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150', 03:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:14 INFO - '_': '/tools/buildbot/bin/python'} 03:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:14 INFO - Downloading/unpacking jsonschema==2.5.1 03:00:14 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 03:00:14 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 03:00:14 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 03:00:14 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 03:00:14 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 03:00:14 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 03:00:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:00:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:15 INFO - Downloading functools32-3.2.3-2.tar.gz 03:00:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:00:16 INFO - warning: no files found matching '*.txt' 03:00:16 INFO - no previously-included directories found matching 'build' 03:00:16 INFO - no previously-included directories found matching 'dist' 03:00:16 INFO - no previously-included directories found matching '.git*' 03:00:16 INFO - Installing collected packages: jsonschema, functools32 03:00:16 INFO - Running setup.py install for functools32 03:00:16 INFO - warning: no files found matching '*.txt' 03:00:16 INFO - no previously-included directories found matching 'build' 03:00:16 INFO - no previously-included directories found matching 'dist' 03:00:16 INFO - no previously-included directories found matching '.git*' 03:00:16 INFO - Successfully installed jsonschema functools32 03:00:16 INFO - Cleaning up... 03:00:16 INFO - Return code: 0 03:00:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1bf51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c32a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e93310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e90400>, '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 0x1e913b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e91840>, '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': 'fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150', '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 03:00:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:00:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:00:16 INFO - Using env: {'DISPLAY': ':0', 03:00:16 INFO - 'HOME': '/home/cltbld', 03:00:16 INFO - 'LANG': 'en_US.UTF-8', 03:00:16 INFO - 'LANGUAGE': 'en_US:en', 03:00:16 INFO - 'LOGNAME': 'cltbld', 03:00:16 INFO - 'MAIL': '/var/mail/cltbld', 03:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:16 INFO - 'MOZ_NO_REMOTE': '1', 03:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:16 INFO - 'NO_EM_RESTART': '1', 03:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:16 INFO - 'PWD': '/builds/slave/test', 03:00:16 INFO - 'SHELL': '/bin/bash', 03:00:16 INFO - 'SHLVL': '1', 03:00:16 INFO - 'TERM': 'linux', 03:00:16 INFO - 'TMOUT': '86400', 03:00:16 INFO - 'USER': 'cltbld', 03:00:16 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150', 03:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:16 INFO - '_': '/tools/buildbot/bin/python'} 03:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:00:16 INFO - Cleaning up... 03:00:16 INFO - Return code: 0 03:00:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1bf51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c32a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e93310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e90400>, '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 0x1e913b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e91840>, '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': 'fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150', '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 03:00:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:00:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:00:16 INFO - Using env: {'DISPLAY': ':0', 03:00:16 INFO - 'HOME': '/home/cltbld', 03:00:16 INFO - 'LANG': 'en_US.UTF-8', 03:00:16 INFO - 'LANGUAGE': 'en_US:en', 03:00:16 INFO - 'LOGNAME': 'cltbld', 03:00:16 INFO - 'MAIL': '/var/mail/cltbld', 03:00:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:16 INFO - 'MOZ_NO_REMOTE': '1', 03:00:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:16 INFO - 'NO_EM_RESTART': '1', 03:00:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:16 INFO - 'PWD': '/builds/slave/test', 03:00:16 INFO - 'SHELL': '/bin/bash', 03:00:16 INFO - 'SHLVL': '1', 03:00:16 INFO - 'TERM': 'linux', 03:00:16 INFO - 'TMOUT': '86400', 03:00:16 INFO - 'USER': 'cltbld', 03:00:16 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150', 03:00:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:16 INFO - '_': '/tools/buildbot/bin/python'} 03:00:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:16 INFO - Downloading/unpacking blobuploader==1.2.4 03:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:17 INFO - Downloading blobuploader-1.2.4.tar.gz 03:00:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:00:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:00:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:18 INFO - Downloading docopt-0.6.1.tar.gz 03:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:00:18 INFO - Installing collected packages: blobuploader, requests, docopt 03:00:18 INFO - Running setup.py install for blobuploader 03:00:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:00:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:00:18 INFO - Running setup.py install for requests 03:00:18 INFO - Running setup.py install for docopt 03:00:18 INFO - Successfully installed blobuploader requests docopt 03:00:18 INFO - Cleaning up... 03:00:18 INFO - Return code: 0 03:00:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:18 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')]} 03:00:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:18 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')]} 03:00:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:19 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 0x1bf51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c32a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e93310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e90400>, '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 0x1e913b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e91840>, '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': 'fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150', '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 03:00:19 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 03:00:19 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 03:00:19 INFO - Using env: {'DISPLAY': ':0', 03:00:19 INFO - 'HOME': '/home/cltbld', 03:00:19 INFO - 'LANG': 'en_US.UTF-8', 03:00:19 INFO - 'LANGUAGE': 'en_US:en', 03:00:19 INFO - 'LOGNAME': 'cltbld', 03:00:19 INFO - 'MAIL': '/var/mail/cltbld', 03:00:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:19 INFO - 'MOZ_NO_REMOTE': '1', 03:00:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:19 INFO - 'NO_EM_RESTART': '1', 03:00:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:19 INFO - 'PWD': '/builds/slave/test', 03:00:19 INFO - 'SHELL': '/bin/bash', 03:00:19 INFO - 'SHLVL': '1', 03:00:19 INFO - 'TERM': 'linux', 03:00:19 INFO - 'TMOUT': '86400', 03:00:19 INFO - 'USER': 'cltbld', 03:00:19 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150', 03:00:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:19 INFO - '_': '/tools/buildbot/bin/python'} 03:00:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:19 INFO - Running setup.py (path:/tmp/pip-rvfxsL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:19 INFO - Running setup.py (path:/tmp/pip-NQgc6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:19 INFO - Running setup.py (path:/tmp/pip-EMOAIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:19 INFO - Running setup.py (path:/tmp/pip-LBTvL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:19 INFO - Running setup.py (path:/tmp/pip-SmGDyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:19 INFO - Running setup.py (path:/tmp/pip-TwWkD9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:19 INFO - Running setup.py (path:/tmp/pip-rswTEK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:19 INFO - Running setup.py (path:/tmp/pip-RgGTnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:19 INFO - Running setup.py (path:/tmp/pip-1KlKPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:19 INFO - Running setup.py (path:/tmp/pip-_o4xfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:19 INFO - Running setup.py (path:/tmp/pip-oKNHJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:20 INFO - Running setup.py (path:/tmp/pip-HUxF73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:20 INFO - Running setup.py (path:/tmp/pip-g9nNcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:20 INFO - Running setup.py (path:/tmp/pip-C8TxWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:20 INFO - Running setup.py (path:/tmp/pip-Mzweij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:20 INFO - Running setup.py (path:/tmp/pip-RBPwb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:20 INFO - Running setup.py (path:/tmp/pip-sc3gnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:00:20 INFO - Running setup.py install for manifestparser 03:00:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:00:20 INFO - Running setup.py install for mozcrash 03:00:20 INFO - Running setup.py install for mozdebug 03:00:20 INFO - Running setup.py install for mozdevice 03:00:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:00:20 INFO - Running setup.py install for mozfile 03:00:20 INFO - Running setup.py install for mozhttpd 03:00:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:00:21 INFO - Running setup.py install for mozinfo 03:00:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:00:21 INFO - Running setup.py install for mozInstall 03:00:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:00:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:00:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:00:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:00:21 INFO - Running setup.py install for mozleak 03:00:21 INFO - Running setup.py install for mozlog 03:00:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:00:21 INFO - Running setup.py install for moznetwork 03:00:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:00:21 INFO - Running setup.py install for mozprocess 03:00:21 INFO - Running setup.py install for mozprofile 03:00:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:00:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:00:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:00:21 INFO - Running setup.py install for mozrunner 03:00:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:00:21 INFO - Running setup.py install for mozscreenshot 03:00:21 INFO - Running setup.py install for moztest 03:00:22 INFO - Running setup.py install for mozversion 03:00:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:00:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:00:22 INFO - Cleaning up... 03:00:22 INFO - Return code: 0 03:00:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:22 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')]} 03:00:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:22 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')]} 03:00:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:22 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 0x1bf51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c32a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e93310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e90400>, '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 0x1e913b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e91840>, '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': 'fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150', '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 03:00:22 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 03:00:22 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 03:00:22 INFO - Using env: {'DISPLAY': ':0', 03:00:22 INFO - 'HOME': '/home/cltbld', 03:00:22 INFO - 'LANG': 'en_US.UTF-8', 03:00:22 INFO - 'LANGUAGE': 'en_US:en', 03:00:22 INFO - 'LOGNAME': 'cltbld', 03:00:22 INFO - 'MAIL': '/var/mail/cltbld', 03:00:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:22 INFO - 'MOZ_NO_REMOTE': '1', 03:00:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:22 INFO - 'NO_EM_RESTART': '1', 03:00:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:22 INFO - 'PWD': '/builds/slave/test', 03:00:22 INFO - 'SHELL': '/bin/bash', 03:00:22 INFO - 'SHLVL': '1', 03:00:22 INFO - 'TERM': 'linux', 03:00:22 INFO - 'TMOUT': '86400', 03:00:22 INFO - 'USER': 'cltbld', 03:00:22 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150', 03:00:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:22 INFO - '_': '/tools/buildbot/bin/python'} 03:00:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:00:22 INFO - Running setup.py (path:/tmp/pip-fhVWZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:00:22 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)) 03:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:00:22 INFO - Running setup.py (path:/tmp/pip-yEYRml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:00:22 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)) 03:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:00:22 INFO - Running setup.py (path:/tmp/pip-txyOup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:00:22 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)) 03:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:00:22 INFO - Running setup.py (path:/tmp/pip-Ol7ZEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:00:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 03:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:00:22 INFO - Running setup.py (path:/tmp/pip-DPDNo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:00:22 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)) 03:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:00:22 INFO - Running setup.py (path:/tmp/pip-ea9Bxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:00:22 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)) 03:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:00:22 INFO - Running setup.py (path:/tmp/pip-fXKIi5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:00:22 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)) 03:00:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:00:22 INFO - Running setup.py (path:/tmp/pip-oWywpY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:00:23 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)) 03:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:00:23 INFO - Running setup.py (path:/tmp/pip-MckXTR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:00:23 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)) 03:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:00:23 INFO - Running setup.py (path:/tmp/pip-aRQ3LP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:00:23 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)) 03:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:00:23 INFO - Running setup.py (path:/tmp/pip-NHDHgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:00:23 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)) 03:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:00:23 INFO - Running setup.py (path:/tmp/pip-PtHYcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:00:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 03:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:00:23 INFO - Running setup.py (path:/tmp/pip-RsNwzx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:00:23 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)) 03:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:00:23 INFO - Running setup.py (path:/tmp/pip-uSEXGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:00:23 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)) 03:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:23 INFO - Running setup.py (path:/tmp/pip-E5rVKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:00:23 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)) 03:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:00:23 INFO - Running setup.py (path:/tmp/pip-Hwdw2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:00:23 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)) 03:00:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:00:23 INFO - Running setup.py (path:/tmp/pip-ci2rSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:00:23 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)) 03:00:23 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)) 03:00:23 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)) 03:00:23 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)) 03:00:23 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:00:23 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:00:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:00:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:00:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:00:24 INFO - Downloading blessings-1.6.tar.gz 03:00:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:00:24 INFO - Installing collected packages: blessings 03:00:24 INFO - Running setup.py install for blessings 03:00:24 INFO - Successfully installed blessings 03:00:24 INFO - Cleaning up... 03:00:24 INFO - Return code: 0 03:00:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:00:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:25 INFO - Reading from file tmpfile_stdout 03:00:25 INFO - Current package versions: 03:00:25 INFO - argparse == 1.2.1 03:00:25 INFO - blessings == 1.6 03:00:25 INFO - blobuploader == 1.2.4 03:00:25 INFO - docopt == 0.6.1 03:00:25 INFO - functools32 == 3.2.3-2 03:00:25 INFO - jsonschema == 2.5.1 03:00:25 INFO - manifestparser == 1.1 03:00:25 INFO - mozInstall == 1.12 03:00:25 INFO - mozcrash == 1.0 03:00:25 INFO - mozdebug == 0.1 03:00:25 INFO - mozdevice == 0.50 03:00:25 INFO - mozfile == 1.2 03:00:25 INFO - mozhttpd == 0.7 03:00:25 INFO - mozinfo == 0.9 03:00:25 INFO - mozleak == 0.1 03:00:25 INFO - mozlog == 3.4 03:00:25 INFO - moznetwork == 0.27 03:00:25 INFO - mozprocess == 0.25 03:00:25 INFO - mozprofile == 0.28 03:00:25 INFO - mozrunner == 6.13 03:00:25 INFO - mozscreenshot == 0.1 03:00:25 INFO - mozsystemmonitor == 0.3 03:00:25 INFO - moztest == 0.8 03:00:25 INFO - mozversion == 1.4 03:00:25 INFO - psutil == 3.1.1 03:00:25 INFO - requests == 1.2.3 03:00:25 INFO - wsgiref == 0.1.2 03:00:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:25 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 0x1bf51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c32a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e93310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e90400>, '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 0x1e913b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e91840>, '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': 'fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150', '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 03:00:25 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 03:00:25 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 03:00:25 INFO - Using env: {'DISPLAY': ':0', 03:00:25 INFO - 'HOME': '/home/cltbld', 03:00:25 INFO - 'LANG': 'en_US.UTF-8', 03:00:25 INFO - 'LANGUAGE': 'en_US:en', 03:00:25 INFO - 'LOGNAME': 'cltbld', 03:00:25 INFO - 'MAIL': '/var/mail/cltbld', 03:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:25 INFO - 'MOZ_NO_REMOTE': '1', 03:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:25 INFO - 'NO_EM_RESTART': '1', 03:00:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:25 INFO - 'PWD': '/builds/slave/test', 03:00:25 INFO - 'SHELL': '/bin/bash', 03:00:25 INFO - 'SHLVL': '1', 03:00:25 INFO - 'TERM': 'linux', 03:00:25 INFO - 'TMOUT': '86400', 03:00:25 INFO - 'USER': 'cltbld', 03:00:25 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150', 03:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:25 INFO - '_': '/tools/buildbot/bin/python'} 03:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:25 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)) 03:00:25 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)) 03:00:25 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)) 03:00:25 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)) 03:00:25 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)) 03:00:25 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)) 03:00:25 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)) 03:00:25 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)) 03:00:25 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)) 03:00:25 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)) 03:00:25 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)) 03:00:25 INFO - Cleaning up... 03:00:25 INFO - Return code: 0 03:00:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:00:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:00:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:00:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:00:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1bf51f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c32a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e93310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e90400>, '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 0x1e913b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e91840>, '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': 'fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150', '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 03:00:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:00:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:00:25 INFO - Using env: {'DISPLAY': ':0', 03:00:25 INFO - 'HOME': '/home/cltbld', 03:00:25 INFO - 'LANG': 'en_US.UTF-8', 03:00:25 INFO - 'LANGUAGE': 'en_US:en', 03:00:25 INFO - 'LOGNAME': 'cltbld', 03:00:25 INFO - 'MAIL': '/var/mail/cltbld', 03:00:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:25 INFO - 'MOZ_NO_REMOTE': '1', 03:00:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:25 INFO - 'NO_EM_RESTART': '1', 03:00:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:25 INFO - 'PWD': '/builds/slave/test', 03:00:25 INFO - 'SHELL': '/bin/bash', 03:00:25 INFO - 'SHLVL': '1', 03:00:25 INFO - 'TERM': 'linux', 03:00:25 INFO - 'TMOUT': '86400', 03:00:25 INFO - 'USER': 'cltbld', 03:00:25 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150', 03:00:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:25 INFO - '_': '/tools/buildbot/bin/python'} 03:00:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:00:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:00:25 INFO - Cleaning up... 03:00:25 INFO - Return code: 0 03:00:25 INFO - Running post-action listener: _resource_record_post_action 03:00:25 INFO - Running post-action listener: _start_resource_monitoring 03:00:25 INFO - Starting resource monitoring. 03:00:25 INFO - [mozharness: 2017-05-04 10:00:25.716149Z] Finished create-virtualenv step (success) 03:00:25 INFO - [mozharness: 2017-05-04 10:00:25.716618Z] Running install step. 03:00:25 INFO - Running pre-action listener: _resource_record_pre_action 03:00:25 INFO - Running main action method: install 03:00:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:00:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:00:25 INFO - Reading from file tmpfile_stdout 03:00:25 INFO - Detecting whether we're running mozinstall >=1.0... 03:00:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:00:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:00:26 INFO - Reading from file tmpfile_stdout 03:00:26 INFO - Output received: 03:00:26 INFO - Usage: mozinstall [options] installer 03:00:26 INFO - Options: 03:00:26 INFO - -h, --help show this help message and exit 03:00:26 INFO - -d DEST, --destination=DEST 03:00:26 INFO - Directory to install application into. [default: 03:00:26 INFO - "/builds/slave/test"] 03:00:26 INFO - --app=APP Application being installed. [default: firefox] 03:00:26 INFO - mkdir: /builds/slave/test/build/application 03:00:26 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'] 03:00:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 03:00:41 INFO - Reading from file tmpfile_stdout 03:00:41 INFO - Output received: 03:00:41 INFO - /builds/slave/test/build/application/firefox/firefox 03:00:41 INFO - Running post-action listener: _resource_record_post_action 03:00:41 INFO - [mozharness: 2017-05-04 10:00:41.349313Z] Finished install step (success) 03:00:41 INFO - [mozharness: 2017-05-04 10:00:41.349582Z] Running run-tests step. 03:00:41 INFO - Running pre-action listener: _resource_record_pre_action 03:00:41 INFO - Running main action method: run_tests 03:00:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:00:41 INFO - Python 2.7.3 03:00:41 INFO - Return code: 0 03:00:41 INFO - grabbing minidump binary from tooltool 03:00:41 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')]} 03:00:41 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 0x1e90400>, '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 0x1e913b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1e91840>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:00:41 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 03:00:41 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 03:00:41 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 03:00:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:00:41 INFO - Return code: 0 03:00:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:00:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:00:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:00:41 INFO - ENV: RUST_BACKTRACE is now 1 03:00:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:00:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:00:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 03:00:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-048 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 03:00:41 INFO - Using env: {'DISPLAY': ':0', 03:00:41 INFO - 'HOME': '/home/cltbld', 03:00:41 INFO - 'LANG': 'en_US.UTF-8', 03:00:41 INFO - 'LANGUAGE': 'en_US:en', 03:00:41 INFO - 'LOGNAME': 'cltbld', 03:00:41 INFO - 'MAIL': '/var/mail/cltbld', 03:00:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:00:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:00:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:00:41 INFO - 'MOZ_NO_REMOTE': '1', 03:00:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:00:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:00:41 INFO - 'NO_EM_RESTART': '1', 03:00:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:00:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:00:41 INFO - 'PWD': '/builds/slave/test', 03:00:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:00:41 INFO - 'RUST_BACKTRACE': '1', 03:00:41 INFO - 'SHELL': '/bin/bash', 03:00:41 INFO - 'SHLVL': '1', 03:00:41 INFO - 'TERM': 'linux', 03:00:41 INFO - 'TMOUT': '86400', 03:00:41 INFO - 'USER': 'cltbld', 03:00:41 INFO - 'XDG_SESSION_COOKIE': 'fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150', 03:00:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:00:41 INFO - '_': '/tools/buildbot/bin/python'} 03:00:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-048', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 03:00:41 INFO - mozversion application_buildid: 20170504092810 03:00:41 INFO - mozversion application_changeset: 33b92d9c40562dab3d7b602368c75619f1d793f7 03:00:41 INFO - mozversion application_display_name: Nightly 03:00:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:00:41 INFO - mozversion application_name: Firefox 03:00:41 INFO - mozversion application_remotingname: firefox 03:00:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:00:41 INFO - mozversion application_vendor: Mozilla 03:00:41 INFO - mozversion application_version: 55.0a1 03:00:41 INFO - mozversion platform_buildid: 20170504092810 03:00:41 INFO - mozversion platform_changeset: 33b92d9c40562dab3d7b602368c75619f1d793f7 03:00:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:00:41 INFO - mozversion platform_version: 55.0a1 03:00:41 INFO - using testdate: 1493892041 03:00:41 INFO - actual date: 1493892041 03:00:41 INFO - starting webserver on 'localhost:33031' 03:00:41 INFO - SUITE-START | Running 2 tests 03:00:41 INFO - TEST-START | dromaeo_css 03:00:41 INFO - operating with platform_type : linux_ 03:00:41 INFO - Initialising browser for dromaeo_css test... 03:00:41 INFO - TEST-INFO | started process 2367 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB4AR3u/profile http://localhost:33031/getInfo.html) 03:00:46 INFO - PID 2367 | __metrics Screen width/height:1600/1200 03:00:46 INFO - PID 2367 | colorDepth:24 03:00:46 INFO - PID 2367 | Browser inner width/height: 1024/695 03:00:46 INFO - PID 2367 | __metrics 03:00:47 INFO - PID 2367 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:00:47 INFO - PID 2367 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:00:48 INFO - TEST-INFO | 2367: exit 0 03:00:48 INFO - Browser initialized. 03:00:48 INFO - Running cycle 1/1 for dromaeo_css test... 03:00:48 INFO - TEST-INFO | started process 2558 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpB4AR3u/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:01:00 INFO - PID 2558 | RSS: Main: 167632896 03:01:00 INFO - PID 2558 | 03:04:06 INFO - PID 2558 | Cycle 1(1): loaded http://localhost:33031/tests/dromaeo/cssquery-dojo.html (next: http://localhost:33031/tests/dromaeo/cssquery-ext.html) 03:04:08 INFO - PID 2558 | RSS: Main: 326303744 03:04:08 INFO - PID 2558 | 03:07:11 INFO - PID 2558 | Cycle 1(1): loaded http://localhost:33031/tests/dromaeo/cssquery-ext.html (next: http://localhost:33031/tests/dromaeo/cssquery-jquery.html) 03:07:11 INFO - PID 2558 | RSS: Main: 256167936 03:07:11 INFO - PID 2558 | 03:10:14 INFO - PID 2558 | Cycle 1(1): loaded http://localhost:33031/tests/dromaeo/cssquery-jquery.html (next: http://localhost:33031/tests/dromaeo/cssquery-mootools.html) 03:10:14 INFO - PID 2558 | RSS: Main: 197636096 03:10:14 INFO - PID 2558 | 03:13:16 INFO - PID 2558 | Cycle 1(1): loaded http://localhost:33031/tests/dromaeo/cssquery-mootools.html (next: http://localhost:33031/tests/dromaeo/cssquery-prototype.html) 03:13:17 INFO - PID 2558 | RSS: Main: 241025024 03:13:17 INFO - PID 2558 | 03:16:20 INFO - PID 2558 | Cycle 1(1): loaded http://localhost:33031/tests/dromaeo/cssquery-prototype.html (next: http://localhost:33031/tests/dromaeo/cssquery-yui.html) 03:16:21 INFO - PID 2558 | RSS: Main: 204345344 03:16:21 INFO - PID 2558 | 03:19:23 INFO - PID 2558 | Cycle 1(1): loaded http://localhost:33031/tests/dromaeo/cssquery-yui.html (next: http://localhost:33031/tests/dromaeo/cssquery-dojo.html) 03:19:23 INFO - PID 2558 | RSS: Main: 292466688 03:19:23 INFO - PID 2558 | 03:19:23 INFO - PID 2558 | __start_tp_report 03:19:23 INFO - PID 2558 | _x_x_mozilla_page_load 03:19:23 INFO - PID 2558 | _x_x_mozilla_page_load_details 03:19:23 INFO - PID 2558 | |i|pagename|runs| 03:19:23 INFO - PID 2558 | |0;dojo.html;2707.0795929384008;2728.4406696627193;2763.778897688184;2772.861356932153;2779.5552711566147;5042.974785126069;5178.197379406189;5181.119209734345;5214.009338225735;5242.449542798004;5195.298634684316;5207.192885102806;5274.393444753854;5283.365996080466;5321.866953326169;4346.826126954918;4559.042601053783;4620.122176786408;4643.279620664627;4722.50413706561;4656.138614356355;4672.766361681919;4676.228422310314;4693.7653117344;4703.459102203256;4540.387047748544;4560.817567297304;4561.996360800652;4562.817487300504;4569.6801223914335;4620.052889157714;4621.607163391116;4626.190416677102;4633.62930965522;4638.466576343696;4567.6574256930535;4587.334836448729;4591.977040114778;4597.7011494252765;4606.101810147023;5007.098722229997;5074.188129899198;5076.746162691888;5094.872628184288;5100.668456550312;5641.943580564182;5647.322321321427;5669.121286200604;5697.344805347397;5699.458551437607;5623.606347555673;5667.319921609434;5669.149627555858;5683.9715801420725;5693.231413759131;5198.090334191501;5220.504052115081;5280.20796880471;5283.181106928432;5330.333708286465;5787.971060144757;5807.157962095557;5909;5920.2007728956905;5920.615160014585;5409.83770486886;5417.6478528895495;5502.257195278667;5503.587230957694;5504.779808807602;5711.514521265739;5713.457221563945;5714.971425142848;5716.399778023331;5756.65460072397;5645.661260324394;5658.943410565924;5662;5662.745176467069;5669.914951275734;5522.806701765419;5568.805091821848;5613.270274864241;5622.072358060956;5655.858603534944;4734.100520901018;4735.100330937111;4735.12400205963;4778.092162489116;4783.091212669582;4026.0941288210506;4028.1742242840733;4031.5968403160036;4039.6768258539246;4070.4911886014247;4734.029523947583;4748.382710247645;4797.664163508521;4837.830675926326;4881.536254055859;5596.692181929951;5652.378238393773;5665.716714164275;5674.06377947634;5700.3444603871085;4768.785404656799;4800.4479484859685;4813.133635945494;4814.566688997937;4861.854144375674;4932.457429682732;5020.246962955513;5034.471380504994;5038.118329292359;5038.445770965191;5235.293235413171;5314.256004159343;5337.919931201112;5339.25250464943;5341.5459685927135;5702.0306547887785;5703.173039909273;5722.971385143048;5734.025215713255;5755.395683453177;5282.603804714585;5287.947120528899;5293.417724050429;5294.523492885659;5296.3379577552805;5466.371367292653;5599.832005039855;5600;5602.439756024528;5650.3219613646625;5556.666600004012;5611.831645050655;5615.494605485526;5642.322921249476;5664.745086471036;5365.651232669864;5444.428335024765;5513.862153446196;5517.034518959086;5521.309836270466;5471.72641367938;5535.7785688572;5538.252335934597;5565.833025009256;5580.2466666999435;5452.91820622683;5453.045716999589;5453.291072160594;5466.508014278734;5470.398256191896;5417.079096553674;5533.391326954113;5537.723113844372;5539.196816461671;5540;5358.7320633967365;5386.192071189353;5387.595930305164;5387.730613469233;5389.083855744454 03:19:23 INFO - PID 2558 | |1;ext.html;683.8700646877093;734.2217249715302;752.9472936894418;1088.1403691084045;1099.2525082943596;25574.488510229807;26187.86906065467;26214;26224;29546.40907181855;33924.83037584815;34113.65886341136;34336.82831585839;34424.65575344246;34433.65566344336;6777.59334439934;6926.757563485279;6928.965355173217;6932.757353492629;6935.167779866423;5213.6089793265655;5385.623006389555;6862.862742745142;6956.304369563029;6966.094407726989;6730.293319201487;6910.032595436643;6911.481638877104;6926.37662610365;6926.965365173192;6896.896546551806;6953.826154346131;6957.652117394161;6960.617166055865;6962.651867406609;5176.870578235536;5331.893362132774;6788.321167883221;6872.553284036571;6873.931260687429;28996.27509312263;29722;29776.404471910657;29867.850660746775;29921.700782992328;3030.424219398329;3084;3084.0593618946214;3084.15185823898;3085.3674996625864;23727.644085338732;23749.643755343684;23806.28581142551;23811.642825357634;23823.16618918347;3126.296583268769;3134.9373012539622;3148.275896543808;3165.0030240474175;3167.04988503448;139547;139616;139618;140297;141886.2905685465;40372.596274037474;40408;40463;40465.79767101146;40484.39273410901;42593.14813703771;42667.57332426698;42683.57316426796;42726.57273427226;42730;12926.612201633967;13064.738705225842;13072.673183170496;13089.149205301625;13106.60680179596;10672.679819605424;10687.358758474516;10714.839277410845;10720.195985301134;10742.94628526868;9990.400575965465;10222.080012798735;10252.23108266883;11309.830352544719;11688.298702077733;4448.621867141329;5382.407935127133;5569.805056822992;5575.414581468968;5649.237352957381;885.3669626217286;920.7145784806731;931.189864817613;933.4119504711988;949.1030975728008;20866;21872.45318867041;21887.233946811786;21974.670379944313;21976.780232197794;998.4308943901906;1000.7348052766023;1014.4724743133529;1027.465717826726;1027.5170669785189;10421.89327229652;11188.720281993015;11306.208565400508;11334.093272538343;11485.310881347146;174544.1272793628;174906;175798;176189;176554;40630;41108.1778364431;41169.382459263135;41312.79343603323;41314.1737165261;1218.8598311194326;1254.6486983644595;1260.3572178189006;1265.6013355792895;1271.4723389793317;19133.904330478257;19569.412917612495;20533.691994619792;20739.8963005184;20957.1617135319;29125.85437072801;29255.414891702472;29261.41477170402;29264.56103158412;29276;139812.30093849465;139826.30086849502;140781;141135.29432352772;141142.2942885279;29559.408811824072;29660.258493537833;29802;29855;29885.252868678457;28296.85851570729;31598.842005789826;32856.83571582127;35233.47149792806;35296.47055294224;24609.63085553754;25372.492550148523;26083.08709195169;26210.475790483702;27289.727102728717;25985;26094.73905260923;26529.734702652728;26588;27225.230360026533;27369.589456157777;28271.29321766972;28403.857980709963;28467.00365487198;28645.14064578066;24599.508009839345;24635.753642463347;24854.254372368858;25429.61855572205;26192.476150477265;21465.864254115346;22822.885885570468;22875.428114297276;23098.076076956735;23138.190163344203 03:19:23 INFO - PID 2558 | |2;jquery.html;385.9073822282653;404.18556608433994;417.2322925816497;425.33010508449195;426.3902619254465;12017.098717596182;13754;17605;18141.183646735895;18409.44771656851;17446.38937637183;17496.300147994065;17863.55341116473;17900.910495447504;18301.90849045756;5346.572274218072;5521.337439507265;5523.585731070166;5525.696086715229;5525.723713814314;5310.522053015228;5330.520253177213;5446.863828404302;5471.06991811393;5473.452654734515;5415.675059496423;5446.183072539111;5451.127819548873;5452.563794896419;5458.9454105459035;5235.633505654587;5437.075697131497;5457.154141108134;5493.395726470085;5498.642588231792;4917.704937703714;4965;4967.751612419364;4967.751612419401;4971.900561988776;20969.266075687432;21015.159393624235;21146.3656090316;21157.365279041653;21178.682319765063;1646.3414634146436;1675.7821483207226;1703.957401064971;1704.463094125359;1705.0622157813152;13808.516701915385;13876.930615346959;13892;13955.302234888215;14218.360173792204;1876.4370688793308;1890.6880364739802;1914.5117994911209;1916.089857317777;1948.298612499499;69073;76400.61799691021;91475;91852.54073729656;93258;10780.730481738019;10811.243212975174;10999.450027498753;11096;11299.20905536621;15236.162011089496;15278;15306.311215995307;15419.768703469457;15441.691166176613;6998.230194678581;6998.860022799516;7150.141982962078;7322.890156647654;7333.88999165013;6405.839854003687;6498.642574658439;6585;6588.835279117964;6647.833804154935;6864.279250678706;7030.437564994788;7064.823379415453;7121;7182.7486037989465;1952.160570954503;1983.4545499987619;2022.322521955132;2040.6530889748778;2071.3682326890143;899.4917871402637;918.3204428722697;919.3426699909596;932.1517419148543;955.9808803823885;16513.256903439375;17251.913740431217;17272.22274997628;17288.481345559652;17461;911.2026976395654;914.5244472874068;930.3487558708931;936.5270538378212;940.2524992630875;8930.776730581787;9230.215431688248;9587.712368628952;9598.66404675833;9729.4648794317;332171;338460;340242;341567;341856;60995;76537;76933;76949.2305076942;77874;1094.3543309447464;1112.9276597021167;1123.5505797680994;1145.2613064573304;1148.3798748675622;16872;16890.324387024873;17258.482245532654;18097.18562664657;18218.45344639663;36806.63193368032;38232.80883595564;38778.642747503705;38873;39506.40740388839;45268.77365613283;46079.3088103672;47645;48206;48610.27084593663;8049.959750201211;8082.878756818534;8447.281981031681;8508.532030738368;8576.228139467477;12923;13163.60509184726;13292.867071329163;13301.800472993107;13593.116447430886;10925.125989920629;10989.780204395707;11133.944330278297;11462.197646165023;11543.307401555934;10765.138788897026;10911.890881091087;11006.669799906016;11038.951299626522;11110.000099991039;10966.342019478856;11088.168387370819;11113.833292500458;11355.943220283845;11543.134264929995;7986.361091112581;8138;8158.469699469515;8168.7957801055445;8225.136360682282;11034.393108379116;11223.326600404002;11232.550697972316;11282.097432205239;11731.41342932867 03:19:23 INFO - PID 2558 | |3;mootools.html;1262.741138066696;1285.749278890616;1319.881210691038;1328.3424704771135;1334.4711771193595;9737.1236588707;10242.385456872593;10243.180545556355;10244.385336879792;10253.538590763415;9872.555734991925;10003.49982500874;10356.119729822974;10367.948160259208;10401.479926003689;2225.043231410497;2261.118163916074;2262.2195342606774;2263.1400067974146;2267.841251112423;2110.7256056712604;2226.2875879718495;2226.92205772798;2227.487677834099;2232.854864433815;1773.991130044348;1837.9264829406807;2136.220279597951;2200.3618950504333;2205.8014778669917;2221.0671517962496;2239.3393948785147;2240.19353032908;2245.584566855137;2248.5053288276717;2146.1308170191096;2185.0385830234645;2186.9015894284794;2192.1669765489014;2196.901139448729;9706.757331066709;9897.4556399398;9914.107730304235;9944.701658950244;9956.502174891299;5549.445055494418;5727.541796656299;5744.540436765049;5770.278715160605;5774.913376299359;3343.3647606954846;3514.771539849927;3558.323918455511;3560.9109772255642;3571.482135090397;1048.7849990751877;1052.489542571852;1096.2107282756403;1115.6820306212771;1123.5730422439503;14593.270336483134;14726.484573039892;14730.410783568645;14730.926345368205;14744.926275368554;4563.338315944236;4668.906621867612;4792.976035119872;4887.437944636341;4932.457429682732;10971.615993440191;10971.670849874517;10979.28634638746;10981.890181098086;10989.6153634624;5491.368492623399;5546.057170281062;5559.777608895599;5574.554035677136;5582.7766889324785;5205.765740541685;5230.529252367229;5251.789928402897;5301.443348448434;5312.2297266896085;3696.6857817085847;3775.3581891078584;3783.5838057813617;3812.923741525154;3890.299746045739;1080.400377790334;1088.0914436445498;1097.401915955806;1105.3865104866877;1106.8858480302583;695.9304069593001;717.6160753996587;717.9605121718251;719.1406269507888;731.5281643340122;5231.450697676689;5243.213517972335;5343.038253114477;5393.083175860113;5401.351837779492;549.5576061270635;563.374654133911;564.624524691084;564.8983183027094;565.9236003139606;3355.4295769719206;3363.83180840957;3381.9492707609406;3386.1196089017035;3490.8254587270535;11585.420728963687;11882.940585297018;12007;12044.21712588679;12045.277283363026;11994.460249288803;11994.520219191134;11997.460114294878;12000.459979300953;12010.099242556844;6977.33715297046;7217.639118044077;7226.349628533457;7292.489525733148;7323.560586364835;5564.137558678412;5577.6653400796085;5615.241942337895;5628.324601047901;5864.882702346014;10457.477126143815;10464.581416743245;10501.422421766876;10521.684349469528;10568.20738444635;10875.619353322596;10894.891051089387;11009.559617615527;11123.72190695239;11134;6950.687219075053;7106.538075025107;7106.857862842611;7108.537945033556;7632.847343052997;9791.902080979384;9837;9928.801423971336;9929.3545919515;9930.304878658424;8283.917160828314;8289.875651865348;8393.748187554384;8415.368847336353;8678.78303042429;7628.46600737943;8063.919360806317;8117.553534555656;8130.796730081795;8331.50010999342;7345.412367010733;7512.32389084985;7513.624318784148;7519.285667861544;7537.095548534211;5243.501867322599;5249.2126181073145;5255.185446255837;5290.809567847357;5470.206820011155;5254.474552544868;5383.031054410088;5418;5460.716731567999;5500.037493438552 03:19:23 INFO - PID 2558 | |4;prototype.html;341.7846756543377;359.4751662572644;388.5065966222897;391.49497148678205;396.668781567391;4744.217204161314;5355.973220133898;5361.437049109846;5366.168243922199;5366.785328586851;5158.742062896849;5244.423113457517;5272.446393128724;5281.445448227938;5323.653962492435;4033.7176397652174;4117.876463706094;4200.558941311172;4201.222773786859;4203.5165955915;4095.5290141633795;4206.516250631186;4214.325707886739;4217.578242175789;4219.493660760713;4179.435776170209;4188.931822385288;4189.476315460567;4191.308434108369;4204.306289462251;3989.581093985119;4012.6789856811383;4192.643625291838;4203.054312779631;4205.621494065549;3809.142942837867;3810.5236845394325;3823.541175058983;3855.74937629056;3860;5086.516780905808;5091.109055915237;5110.514501122388;5112.054269960069;5124.154514505102;4827.548302963398;4930.359053323081;4939.481354457766;4947.50524947506;4987.476314986947;5575.944240557583;5597.076482380402;5600.971995140039;5632.183333416631;5632.831015069554;4293.978530107361;4296;4297.097609502009;4304.461942257218;4312.159128969852;5785.27684039495;5877.235959325346;5897.823065308047;5963.314218864843;5997.940020599782;4426.468823741172;4433.202023635777;4438.933415998763;4444.955550444519;4445.444319460003;4270.252705776476;4499.482559505699;4503;4509.706869053501;4515.367848501212;4766.666333356701;4852.4662287148385;4934.851954441372;4937.728424936663;4962.230854217602;5596.38439771633;5632.4930756231315;5633.661980281115;5636.210930469738;5657.377688454267;1514.5759187427318;1561.0399604243535;1561.110167204705;1561.5315405378342;1570.7957965464416;1119.7032786311634;1129.2045647420641;1140.401289323112;1147.145376694368;1148.9770204595861;4891.95108048915;4930.728809915489;4937.950620493749;4942.9258561121615;4947.65366424354;5815.767369305265;5825.553107844179;5832.854178645568;5833.4749872511675;5838.357780644125;4800.591949684246;4885.267209918469;4901.828436004723;4937.259411088366;4943.615787579483;3022.1084779989956;3030.166749116797;3049.7255247027874;3054.1601059708314;3058.4494790937847;5412.107002344648;5418.8916221675345;5430.8099216527235;5431.511163995259;5444.91832622511;5759.798407055733;5852.8536786579825;5890.2342695449315;5912.556558258148;5918.940810591839;5352.732363381815;5360.088784906575;5371.194320851903;5375.274337964403;5377.193420986883;5650.434956504317;5675.77296908119;5691.430856914441;5716.485516303553;5717.1995920570325;5628.409017053151;5641.971790141023;5646.689432081275;5671.773129074791;5684.9431505684415;5346.572274218131;5365.061114305059;5370.140777475585;5370.704611246263;5380.300560927054;4358.237308470942;4414.095110502275;4443.311286750559;4448.5551444855255;4462.888427789331;5479.397266300624;5575.721213939206;5631.465010823965;5704.144378343116;5715.371309155907;5550.250716153268;5562.388137304974;5563.221149039218;5577.749001295033;5587.832365029056;5414.458554144554;5519.972400138135;5527.640703354269;5554.666719996813;5558.082916318924;5495.835124946258;5504.311961004874;5504.889902202013;5519.172124181405;5519.227308176939;5581.967336042845;5608.10270356741;5609.27079479665;5614.52276556481;5632.887667124828;5298.841034768809;5415.214793854948;5454.127339625641;5454.618176727591;5474.835754927359 03:19:23 INFO - PID 2558 | |5;yui.html;752.8293503601897;763.3931024835257;776.9961150194248;777.0325944199469;780.1730166024013;12646.873531264684;13184.93407532961;13185.538506152287;13198.340082995848;13225.272610006457;13250.07249492536;14960.850391496082;15401.460948866792;15542.378304867792;15543.84456155441;905.8188362327528;923.5243849417556;923.7321176858736;924.8289066522681;927.0914503786294;931.3434029009566;934.0705997532465;934.2059249637822;935.1209862729013;935.8783358163429;986.5215370545316;989.2284018465608;991.5984026469256;991.8462638291077;992.2161492420979;944.3625552751865;959.0457494792726;964.9758756031085;977.2426369563609;983.1692220074026;709.3899246647878;712.3161764705836;713.20477667401;713.960732159731;714.3749219432996;13359.53241636538;13570.050096493249;13617.727645447134;13626.659333516642;13672.794908076386;15068;15098.622534436618;15121.395144194219;15207.923960380238;15282.465113721077;11549.826752598718;12009.699757506045;12033.699157521045;12034.277943323428;12075.456604452733;2841.3606938438893;2858.4854726149492;2882.6396700412447;2905.8111222770663;2908.8836446542114;62632.37367626357;63053.684731576046;69102.65448672725;69224.6538767303;69872.30127698708;11575;11797.29216247028;11856.407179640983;11863.644090677293;11866.466009029615;21310.78689213088;21451.356459305935;21750;21924.342269731933;22014.88992555027;5672.688002159921;5840.853978650568;5850.5904586678525;5853.09277062056;5857.26784151981;3018.2756138526597;3077.92305192372;3084.259777653347;3090.258337998909;3091.984540077285;3313.6686331366673;3373.241020770307;3399.9150021249666;3406.489026646023;3410.471376936579;742.3652776875801;763.2596381509926;781.7615627233635;781.9218078192135;783.3576467296875;551.37323612534;594.5035895027614;607.113614123376;608.9756409743561;622.5206590924962;8789.560521973875;9314;10108.797824043479;10414.427206503564;10799.56801727922;572.9942700573024;578.0664227272924;578.7222133375919;579.7333226715758;598.6138940383428;4353.521112677603;4431.667624928144;4434.17967675981;4470.485894122153;4470.619997300266;58884.705576471846;60938.0859287111;61871.690641546506;62318.688406557674;62540.06189907155;54903.450965490636;55552;55672.72163639156;55696.16455753167;55897.16154257689;35893.46159807605;47129.76435117871;48690.75654621704;48807.51192488101;49671.751641241564;9991.950845161153;10158.542865570918;10403.219758518293;10410.375377477072;10459.372437653765;24909.875450622632;25294.873525632254;25323.49353012966;25708.228753137435;25914.35214119662;30131.698683012888;42965.355519666606;43770.343444848986;45022.77488612536;45819.77090114528;13805.309734513034;14035.578932632037;14226.217558034408;14358.784618230526;14375.065620734618;13653.044286899822;14046.648833779238;14343.354549045109;14401.927990359982;14789.556313310617;13606.591802245948;13842.238676872868;14080.78878816798;14118.717625647634;14367.85632143707;12559.93720031394;12941.158824676366;12999;13821.239831809347;13976.860231397555;12376.62870113898;12903.161294515827;13243;13244.801327979896;13599.932000339935;9636.46999415011;9929.404235745878;9940.850887236842;10096.293259471766;10988.560457581607;10436.739081522719;10443.06012458852;10679.786404271716;10783.460826958464;11043.83434248503 03:19:23 INFO - PID 2558 | __end_tp_report 03:19:23 INFO - PID 2558 | __start_cc_report 03:19:23 INFO - PID 2558 | _x_x_mozilla_cycle_collect,1829 03:19:23 INFO - PID 2558 | __end_cc_report 03:19:23 INFO - PID 2558 | __startTimestamp1493893163781__endTimestamp 03:19:23 INFO - PID 2558 | 03:19:23 INFO - PID 2558 | ------- Summary: start ------- 03:19:23 INFO - PID 2558 | Number of tests: 6 03:19:23 INFO - PID 2558 | 03:19:23 INFO - PID 2558 | [#0] dojo.html Cycles:165 Average:5156.73 Median:5337.92 stddev:617.28 (11.6%) stddev-sans-first:588.50 03:19:23 INFO - PID 2558 | Values: 2707.1 2728.4 2763.8 2772.9 2779.6 5043.0 5178.2 5181.1 5214.0 5242.4 5195.3 5207.2 5274.4 5283.4 5321.9 4346.8 4559.0 4620.1 4643.3 4722.5 4656.1 4672.8 4676.2 4693.8 4703.5 4540.4 4560.8 4562.0 4562.8 4569.7 4620.1 4621.6 4626.2 4633.6 4638.5 4567.7 4587.3 4592.0 4597.7 4606.1 5007.1 5074.2 5076.7 5094.9 5100.7 5641.9 5647.3 5669.1 5697.3 5699.5 5623.6 5667.3 5669.1 5684.0 5693.2 5198.1 5220.5 5280.2 5283.2 5330.3 5788.0 5807.2 5909.0 5920.2 5920.6 5409.8 5417.6 5502.3 5503.6 5504.8 5711.5 5713.5 5715.0 5716.4 5756.7 5645.7 5658.9 5662.0 5662.7 5669.9 5522.8 5568.8 5613.3 5622.1 5655.9 4734.1 4735.1 4735.1 4778.1 4783.1 4026.1 4028.2 4031.6 4039.7 4070.5 4734.0 4748.4 4797.7 4837.8 4881.5 5596.7 5652.4 5665.7 5674.1 5700.3 4768.8 4800.4 4813.1 4814.6 4861.9 4932.5 5020.2 5034.5 5038.1 5038.4 5235.3 5314.3 5337.9 5339.3 5341.5 5702.0 5703.2 5723.0 5734.0 5755.4 5282.6 5287.9 5293.4 5294.5 5296.3 5466.4 5599.8 5600.0 5602.4 5650.3 5556.7 5611.8 5615.5 5642.3 5664.7 5365.7 5444.4 5513.9 5517.0 5521.3 5471.7 5535.8 5538.3 5565.8 5580.2 5452.9 5453.0 5453.3 5466.5 5470.4 5417.1 5533.4 5537.7 5539.2 5540.0 5358.7 5386.2 5387.6 5387.7 5389.1 03:19:23 INFO - PID 2558 | 03:19:23 INFO - PID 2558 | [#1] ext.html Cycles:180 Average:29205.98 Median:29061.06 stddev:39489.35 (135.9%) stddev-sans-first:39542.05 03:19:23 INFO - PID 2558 | Values: 683.9 734.2 752.9 1088.1 1099.3 25574.5 26187.9 26214.0 26224.0 29546.4 33924.8 34113.7 34336.8 34424.7 34433.7 6777.6 6926.8 6929.0 6932.8 6935.2 5213.6 5385.6 6862.9 6956.3 6966.1 6730.3 6910.0 6911.5 6926.4 6927.0 6896.9 6953.8 6957.7 6960.6 6962.7 5176.9 5331.9 6788.3 6872.6 6873.9 28996.3 29722.0 29776.4 29867.9 29921.7 3030.4 3084.0 3084.1 3084.2 3085.4 23727.6 23749.6 23806.3 23811.6 23823.2 3126.3 3134.9 3148.3 3165.0 3167.0 139547.0 139616.0 139618.0 140297.0 141886.3 40372.6 40408.0 40463.0 40465.8 40484.4 42593.1 42667.6 42683.6 42726.6 42730.0 12926.6 13064.7 13072.7 13089.1 13106.6 10672.7 10687.4 10714.8 10720.2 10742.9 9990.4 10222.1 10252.2 11309.8 11688.3 4448.6 5382.4 5569.8 5575.4 5649.2 885.4 920.7 931.2 933.4 949.1 20866.0 21872.5 21887.2 21974.7 21976.8 998.4 1000.7 1014.5 1027.5 1027.5 10421.9 11188.7 11306.2 11334.1 11485.3 174544.1 174906.0 175798.0 176189.0 176554.0 40630.0 41108.2 41169.4 41312.8 41314.2 1218.9 1254.6 1260.4 1265.6 1271.5 19133.9 19569.4 20533.7 20739.9 20957.2 29125.9 29255.4 29261.4 29264.6 29276.0 139812.3 139826.3 140781.0 141135.3 141142.3 29559.4 29660.3 29802.0 29855.0 29885.3 28296.9 31598.8 32856.8 35233.5 35296.5 24609.6 25372.5 26083.1 26210.5 27289.7 25985.0 26094.7 26529.7 26588.0 27225.2 27369.6 28271.3 28403.9 28467.0 28645.1 24599.5 24635.8 24854.3 25429.6 26192.5 21465.9 22822.9 22875.4 23098.1 23138.2 03:19:23 INFO - PID 2558 | 03:19:23 INFO - PID 2558 | [#2] jquery.html Cycles:180 Average:23689.70 Median:37519.72 stddev:56537.18 (150.7%) stddev-sans-first:56668.71 03:19:23 INFO - PID 2558 | Values: 385.9 404.2 417.2 425.3 426.4 12017.1 13754.0 17605.0 18141.2 18409.4 17446.4 17496.3 17863.6 17900.9 18301.9 5346.6 5521.3 5523.6 5525.7 5525.7 5310.5 5330.5 5446.9 5471.1 5473.5 5415.7 5446.2 5451.1 5452.6 5458.9 5235.6 5437.1 5457.2 5493.4 5498.6 4917.7 4965.0 4967.8 4967.8 4971.9 20969.3 21015.2 21146.4 21157.4 21178.7 1646.3 1675.8 1704.0 1704.5 1705.1 13808.5 13876.9 13892.0 13955.3 14218.4 1876.4 1890.7 1914.5 1916.1 1948.3 69073.0 76400.6 91475.0 91852.5 93258.0 10780.7 10811.2 10999.5 11096.0 11299.2 15236.2 15278.0 15306.3 15419.8 15441.7 6998.2 6998.9 7150.1 7322.9 7333.9 6405.8 6498.6 6585.0 6588.8 6647.8 6864.3 7030.4 7064.8 7121.0 7182.7 1952.2 1983.5 2022.3 2040.7 2071.4 899.5 918.3 919.3 932.2 956.0 16513.3 17251.9 17272.2 17288.5 17461.0 911.2 914.5 930.3 936.5 940.3 8930.8 9230.2 9587.7 9598.7 9729.5 332171.0 338460.0 340242.0 341567.0 341856.0 60995.0 76537.0 76933.0 76949.2 77874.0 1094.4 1112.9 1123.6 1145.3 1148.4 16872.0 16890.3 17258.5 18097.2 18218.5 36806.6 38232.8 38778.6 38873.0 39506.4 45268.8 46079.3 47645.0 48206.0 48610.3 8050.0 8082.9 8447.3 8508.5 8576.2 12923.0 13163.6 13292.9 13301.8 13593.1 10925.1 10989.8 11133.9 11462.2 11543.3 10765.1 10911.9 11006.7 11039.0 11110.0 10966.3 11088.2 11113.8 11355.9 11543.1 7986.4 8138.0 8158.5 8168.8 8225.1 11034.4 11223.3 11232.6 11282.1 11731.4 03:19:23 INFO - PID 2558 | 03:19:23 INFO - PID 2558 | [#3] mootools.html Cycles:180 Average:6080.75 Median:3798.25 stddev:3808.90 (100.3%) stddev-sans-first:3802.38 03:19:23 INFO - PID 2558 | Values: 1262.7 1285.7 1319.9 1328.3 1334.5 9737.1 10242.4 10243.2 10244.4 10253.5 9872.6 10003.5 10356.1 10367.9 10401.5 2225.0 2261.1 2262.2 2263.1 2267.8 2110.7 2226.3 2226.9 2227.5 2232.9 1774.0 1837.9 2136.2 2200.4 2205.8 2221.1 2239.3 2240.2 2245.6 2248.5 2146.1 2185.0 2186.9 2192.2 2196.9 9706.8 9897.5 9914.1 9944.7 9956.5 5549.4 5727.5 5744.5 5770.3 5774.9 3343.4 3514.8 3558.3 3560.9 3571.5 1048.8 1052.5 1096.2 1115.7 1123.6 14593.3 14726.5 14730.4 14730.9 14744.9 4563.3 4668.9 4793.0 4887.4 4932.5 10971.6 10971.7 10979.3 10981.9 10989.6 5491.4 5546.1 5559.8 5574.6 5582.8 5205.8 5230.5 5251.8 5301.4 5312.2 3696.7 3775.4 3783.6 3812.9 3890.3 1080.4 1088.1 1097.4 1105.4 1106.9 695.9 717.6 718.0 719.1 731.5 5231.5 5243.2 5343.0 5393.1 5401.4 549.6 563.4 564.6 564.9 565.9 3355.4 3363.8 3381.9 3386.1 3490.8 11585.4 11882.9 12007.0 12044.2 12045.3 11994.5 11994.5 11997.5 12000.5 12010.1 6977.3 7217.6 7226.3 7292.5 7323.6 5564.1 5577.7 5615.2 5628.3 5864.9 10457.5 10464.6 10501.4 10521.7 10568.2 10875.6 10894.9 11009.6 11123.7 11134.0 6950.7 7106.5 7106.9 7108.5 7632.8 9791.9 9837.0 9928.8 9929.4 9930.3 8283.9 8289.9 8393.7 8415.4 8678.8 7628.5 8063.9 8117.6 8130.8 8331.5 7345.4 7512.3 7513.6 7519.3 7537.1 5243.5 5249.2 5255.2 5290.8 5470.2 5254.5 5383.0 5418.0 5460.7 5500.0 03:19:23 INFO - PID 2558 | 03:19:23 INFO - PID 2558 | [#4] prototype.html Cycles:180 Average:4695.76 Median:5141.45 stddev:1302.51 (25.3%) stddev-sans-first:1264.51 03:19:23 INFO - PID 2558 | Values: 341.8 359.5 388.5 391.5 396.7 4744.2 5356.0 5361.4 5366.2 5366.8 5158.7 5244.4 5272.4 5281.4 5323.7 4033.7 4117.9 4200.6 4201.2 4203.5 4095.5 4206.5 4214.3 4217.6 4219.5 4179.4 4188.9 4189.5 4191.3 4204.3 3989.6 4012.7 4192.6 4203.1 4205.6 3809.1 3810.5 3823.5 3855.7 3860.0 5086.5 5091.1 5110.5 5112.1 5124.2 4827.5 4930.4 4939.5 4947.5 4987.5 5575.9 5597.1 5601.0 5632.2 5632.8 4294.0 4296.0 4297.1 4304.5 4312.2 5785.3 5877.2 5897.8 5963.3 5997.9 4426.5 4433.2 4438.9 4445.0 4445.4 4270.3 4499.5 4503.0 4509.7 4515.4 4766.7 4852.5 4934.9 4937.7 4962.2 5596.4 5632.5 5633.7 5636.2 5657.4 1514.6 1561.0 1561.1 1561.5 1570.8 1119.7 1129.2 1140.4 1147.1 1149.0 4892.0 4930.7 4938.0 4942.9 4947.7 5815.8 5825.6 5832.9 5833.5 5838.4 4800.6 4885.3 4901.8 4937.3 4943.6 3022.1 3030.2 3049.7 3054.2 3058.4 5412.1 5418.9 5430.8 5431.5 5444.9 5759.8 5852.9 5890.2 5912.6 5918.9 5352.7 5360.1 5371.2 5375.3 5377.2 5650.4 5675.8 5691.4 5716.5 5717.2 5628.4 5642.0 5646.7 5671.8 5684.9 5346.6 5365.1 5370.1 5370.7 5380.3 4358.2 4414.1 4443.3 4448.6 4462.9 5479.4 5575.7 5631.5 5704.1 5715.4 5550.3 5562.4 5563.2 5577.7 5587.8 5414.5 5520.0 5527.6 5554.7 5558.1 5495.8 5504.3 5504.9 5519.2 5519.2 5582.0 5608.1 5609.3 5614.5 5632.9 5298.8 5415.2 5454.1 5454.6 5474.8 03:19:23 INFO - PID 2558 | 03:19:23 INFO - PID 2558 | [#5] yui.html Cycles:180 Average:14870.84 Median:3343.45 stddev:17468.51 (522.5%) stddev-sans-first:17485.34 03:19:23 INFO - PID 2558 | Values: 752.8 763.4 777.0 777.0 780.2 12646.9 13184.9 13185.5 13198.3 13225.3 13250.1 14960.9 15401.5 15542.4 15543.8 905.8 923.5 923.7 924.8 927.1 931.3 934.1 934.2 935.1 935.9 986.5 989.2 991.6 991.8 992.2 944.4 959.0 965.0 977.2 983.2 709.4 712.3 713.2 714.0 714.4 13359.5 13570.1 13617.7 13626.7 13672.8 15068.0 15098.6 15121.4 15207.9 15282.5 11549.8 12009.7 12033.7 12034.3 12075.5 2841.4 2858.5 2882.6 2905.8 2908.9 62632.4 63053.7 69102.7 69224.7 69872.3 11575.0 11797.3 11856.4 11863.6 11866.5 21310.8 21451.4 21750.0 21924.3 22014.9 5672.7 5840.9 5850.6 5853.1 5857.3 3018.3 3077.9 3084.3 3090.3 3092.0 3313.7 3373.2 3399.9 3406.5 3410.5 742.4 763.3 781.8 781.9 783.4 551.4 594.5 607.1 609.0 622.5 8789.6 9314.0 10108.8 10414.4 10799.6 573.0 578.1 578.7 579.7 598.6 4353.5 4431.7 4434.2 4470.5 4470.6 58884.7 60938.1 61871.7 62318.7 62540.1 54903.5 55552.0 55672.7 55696.2 55897.2 35893.5 47129.8 48690.8 48807.5 49671.8 9992.0 10158.5 10403.2 10410.4 10459.4 24909.9 25294.9 25323.5 25708.2 25914.4 30131.7 42965.4 43770.3 45022.8 45819.8 13805.3 14035.6 14226.2 14358.8 14375.1 13653.0 14046.6 14343.4 14401.9 14789.6 13606.6 13842.2 14080.8 14118.7 14367.9 12559.9 12941.2 12999.0 13821.2 13976.9 12376.6 12903.2 13243.0 13244.8 13599.9 9636.5 9929.4 9940.9 10096.3 10988.6 10436.7 10443.1 10679.8 10783.5 11043.8 03:19:23 INFO - PID 2558 | -------- Summary: end -------- 03:19:23 INFO - PID 2558 | 03:19:24 INFO - TEST-INFO | 2558: exit 0 03:19:24 INFO - TEST-OK | dromaeo_css | took 1123036ms 03:19:24 INFO - TEST-START | kraken 03:19:24 INFO - operating with platform_type : linux_ 03:19:24 INFO - Initialising browser for kraken test... 03:19:24 INFO - TEST-INFO | started process 3003 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ3mVOg/profile http://localhost:33031/getInfo.html) 03:19:28 INFO - PID 3003 | __metrics Screen width/height:1600/1200 03:19:28 INFO - PID 3003 | colorDepth:24 03:19:28 INFO - PID 3003 | Browser inner width/height: 1024/695 03:19:28 INFO - PID 3003 | __metrics 03:19:29 INFO - PID 3003 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:19:29 INFO - PID 3003 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:19:31 INFO - TEST-INFO | 3003: exit 0 03:19:31 INFO - Browser initialized. 03:19:31 INFO - Running cycle 1/1 for kraken test... 03:19:31 INFO - TEST-INFO | started process 3106 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQ3mVOg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:19:43 INFO - PID 3106 | RSS: Main: 168869888 03:19:43 INFO - PID 3106 | 03:19:45 INFO - PID 3106 | Cycle 1(1): loaded http://localhost:33031/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:33031/tests/kraken/driver.html?testName=audio-beat-detection) 03:19:46 INFO - PID 3106 | RSS: Main: 244248576 03:19:46 INFO - PID 3106 | 03:19:49 INFO - PID 3106 | Cycle 1(1): loaded http://localhost:33031/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:33031/tests/kraken/driver.html?testName=audio-dft) 03:19:50 INFO - PID 3106 | RSS: Main: 207302656 03:19:50 INFO - PID 3106 | 03:19:53 INFO - PID 3106 | Cycle 1(1): loaded http://localhost:33031/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:33031/tests/kraken/driver.html?testName=audio-fft) 03:19:53 INFO - PID 3106 | RSS: Main: 288387072 03:19:53 INFO - PID 3106 | 03:19:56 INFO - PID 3106 | Cycle 1(1): loaded http://localhost:33031/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:33031/tests/kraken/driver.html?testName=audio-oscillator) 03:19:56 INFO - PID 3106 | RSS: Main: 201916416 03:19:56 INFO - PID 3106 | 03:19:58 INFO - PID 3106 | Cycle 1(1): loaded http://localhost:33031/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:33031/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:19:59 INFO - PID 3106 | RSS: Main: 205393920 03:19:59 INFO - PID 3106 | 03:20:02 INFO - PID 3106 | Cycle 1(1): loaded http://localhost:33031/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:33031/tests/kraken/driver.html?testName=imaging-darkroom) 03:20:03 INFO - PID 3106 | RSS: Main: 266412032 03:20:03 INFO - PID 3106 | 03:20:06 INFO - PID 3106 | Cycle 1(1): loaded http://localhost:33031/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:33031/tests/kraken/driver.html?testName=imaging-desaturate) 03:20:07 INFO - PID 3106 | RSS: Main: 265912320 03:20:07 INFO - PID 3106 | 03:20:10 INFO - PID 3106 | Cycle 1(1): loaded http://localhost:33031/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:33031/tests/kraken/driver.html?testName=json-parse-financial) 03:20:10 INFO - PID 3106 | RSS: Main: 263749632 03:20:10 INFO - PID 3106 | 03:20:12 INFO - PID 3106 | Cycle 1(1): loaded http://localhost:33031/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:33031/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:20:13 INFO - PID 3106 | RSS: Main: 227979264 03:20:13 INFO - PID 3106 | 03:20:14 INFO - PID 3106 | Cycle 1(1): loaded http://localhost:33031/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:33031/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:20:15 INFO - PID 3106 | RSS: Main: 233242624 03:20:15 INFO - PID 3106 | 03:20:17 INFO - PID 3106 | Cycle 1(1): loaded http://localhost:33031/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:33031/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:20:18 INFO - PID 3106 | RSS: Main: 243273728 03:20:18 INFO - PID 3106 | 03:20:20 INFO - PID 3106 | Cycle 1(1): loaded http://localhost:33031/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:33031/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:20:21 INFO - PID 3106 | RSS: Main: 250011648 03:20:21 INFO - PID 3106 | 03:20:24 INFO - PID 3106 | Cycle 1(1): loaded http://localhost:33031/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:33031/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:20:25 INFO - PID 3106 | RSS: Main: 228478976 03:20:25 INFO - PID 3106 | 03:20:27 INFO - PID 3106 | Cycle 1(1): loaded http://localhost:33031/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:33031/tests/kraken/driver.html?testName=ai-astar) 03:20:27 INFO - PID 3106 | RSS: Main: 295505920 03:20:27 INFO - PID 3106 | 03:20:27 INFO - PID 3106 | __start_tp_report 03:20:27 INFO - PID 3106 | _x_x_mozilla_page_load 03:20:27 INFO - PID 3106 | _x_x_mozilla_page_load_details 03:20:27 INFO - PID 3106 | |i|pagename|runs| 03:20:27 INFO - PID 3106 | |0;ai-astar;108;111;111;110;110;111;110;110;111;111 03:20:27 INFO - PID 3106 | |1;audio-beat-detection;148;121;121;175;121;121;119;126;150;122 03:20:27 INFO - PID 3106 | |2;audio-dft;160;160;164;162;162;161;163;161;163;161 03:20:27 INFO - PID 3106 | |3;audio-fft;72;75;76;108;75;76;73;74;94;77 03:20:27 INFO - PID 3106 | |4;audio-oscillator;84;84;116;84;84;83;99;83;83;109 03:20:27 INFO - PID 3106 | |5;imaging-gaussian-blur;114;113;113;114;113;114;113;113;113;113 03:20:27 INFO - PID 3106 | |6;imaging-darkroom;150;149;148;148;150;148;148;148;150;149 03:20:27 INFO - PID 3106 | |7;imaging-desaturate;94;93;94;94;93;94;93;93;94;93 03:20:27 INFO - PID 3106 | |8;json-parse-financial;53;52;52;52;53;53;53;53;52;52 03:20:27 INFO - PID 3106 | |9;json-stringify-tinderbox;55;55;55;55;55;55;55;55;54;55 03:20:27 INFO - PID 3106 | |10;stanford-crypto-aes;80;81;81;81;82;80;79;80;80;81 03:20:27 INFO - PID 3106 | |11;stanford-crypto-ccm;129;137;135;126;131;127;128;128;178;125 03:20:27 INFO - PID 3106 | |12;stanford-crypto-pbkdf2;178;185;188;187;187;185;186;187;180;189 03:20:27 INFO - PID 3106 | |13;stanford-crypto-sha256-iterative;69;71;68;70;68;69;69;69;69;69 03:20:27 INFO - PID 3106 | __end_tp_report 03:20:27 INFO - PID 3106 | __start_cc_report 03:20:27 INFO - PID 3106 | _x_x_mozilla_cycle_collect,1976 03:20:27 INFO - PID 3106 | __end_cc_report 03:20:27 INFO - PID 3106 | __startTimestamp1493893227528__endTimestamp 03:20:27 INFO - PID 3106 | 03:20:27 INFO - PID 3106 | ------- Summary: start ------- 03:20:27 INFO - PID 3106 | Number of tests: 14 03:20:27 INFO - PID 3106 | 03:20:27 INFO - PID 3106 | [#0] ai-astar Cycles:10 Average:110.30 Median:111.00 stddev:0.95 (0.9%) stddev-sans-first:0.53 03:20:27 INFO - PID 3106 | Values: 108.0 111.0 111.0 110.0 110.0 111.0 110.0 110.0 111.0 111.0 03:20:27 INFO - PID 3106 | 03:20:27 INFO - PID 3106 | [#1] audio-beat-detection Cycles:10 Average:132.40 Median:124.00 stddev:18.90 (15.2%) stddev-sans-first:19.19 03:20:27 INFO - PID 3106 | Values: 148.0 121.0 121.0 175.0 121.0 121.0 119.0 126.0 150.0 122.0 03:20:27 INFO - PID 3106 | 03:20:27 INFO - PID 3106 | [#2] audio-dft Cycles:10 Average:161.70 Median:162.00 stddev:1.34 (0.8%) stddev-sans-first:1.27 03:20:27 INFO - PID 3106 | Values: 160.0 160.0 164.0 162.0 162.0 161.0 163.0 161.0 163.0 161.0 03:20:27 INFO - PID 3106 | 03:20:27 INFO - PID 3106 | [#3] audio-fft Cycles:10 Average:80.00 Median:75.50 stddev:11.64 (15.4%) stddev-sans-first:11.98 03:20:27 INFO - PID 3106 | Values: 72.0 75.0 76.0 108.0 75.0 76.0 73.0 74.0 94.0 77.0 03:20:27 INFO - PID 3106 | 03:20:27 INFO - PID 3106 | [#4] audio-oscillator Cycles:10 Average:90.90 Median:84.00 stddev:12.48 (14.9%) stddev-sans-first:12.98 03:20:27 INFO - PID 3106 | Values: 84.0 84.0 116.0 84.0 84.0 83.0 99.0 83.0 83.0 109.0 03:20:27 INFO - PID 3106 | 03:20:27 INFO - PID 3106 | [#5] imaging-gaussian-blur Cycles:10 Average:113.30 Median:113.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 03:20:27 INFO - PID 3106 | Values: 114.0 113.0 113.0 114.0 113.0 114.0 113.0 113.0 113.0 113.0 03:20:27 INFO - PID 3106 | 03:20:27 INFO - PID 3106 | [#6] imaging-darkroom Cycles:10 Average:148.80 Median:149.00 stddev:0.92 (0.6%) stddev-sans-first:0.87 03:20:27 INFO - PID 3106 | Values: 150.0 149.0 148.0 148.0 150.0 148.0 148.0 148.0 150.0 149.0 03:20:27 INFO - PID 3106 | 03:20:27 INFO - PID 3106 | [#7] imaging-desaturate Cycles:10 Average:93.50 Median:94.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 03:20:27 INFO - PID 3106 | Values: 94.0 93.0 94.0 94.0 93.0 94.0 93.0 93.0 94.0 93.0 03:20:27 INFO - PID 3106 | 03:20:27 INFO - PID 3106 | [#8] json-parse-financial Cycles:10 Average:52.50 Median:53.00 stddev:0.53 (1.0%) stddev-sans-first:0.53 03:20:27 INFO - PID 3106 | Values: 53.0 52.0 52.0 52.0 53.0 53.0 53.0 53.0 52.0 52.0 03:20:27 INFO - PID 3106 | 03:20:27 INFO - PID 3106 | [#9] json-stringify-tinderbox Cycles:10 Average:54.90 Median:55.00 stddev:0.32 (0.6%) stddev-sans-first:0.33 03:20:27 INFO - PID 3106 | Values: 55.0 55.0 55.0 55.0 55.0 55.0 55.0 55.0 54.0 55.0 03:20:27 INFO - PID 3106 | 03:20:27 INFO - PID 3106 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:81.00 stddev:0.85 (1.0%) stddev-sans-first:0.88 03:20:27 INFO - PID 3106 | Values: 80.0 81.0 81.0 81.0 82.0 80.0 79.0 80.0 80.0 81.0 03:20:27 INFO - PID 3106 | 03:20:27 INFO - PID 3106 | [#11] stanford-crypto-ccm Cycles:10 Average:134.40 Median:130.00 stddev:15.79 (12.1%) stddev-sans-first:16.63 03:20:27 INFO - PID 3106 | Values: 129.0 137.0 135.0 126.0 131.0 127.0 128.0 128.0 178.0 125.0 03:20:27 INFO - PID 3106 | 03:20:27 INFO - PID 3106 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.20 Median:187.00 stddev:3.52 (1.9%) stddev-sans-first:2.60 03:20:27 INFO - PID 3106 | Values: 178.0 185.0 188.0 187.0 187.0 185.0 186.0 187.0 180.0 189.0 03:20:27 INFO - PID 3106 | 03:20:27 INFO - PID 3106 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.00 stddev:0.88 (1.3%) stddev-sans-first:0.93 03:20:27 INFO - PID 3106 | Values: 69.0 71.0 68.0 70.0 68.0 69.0 69.0 69.0 69.0 69.0 03:20:27 INFO - PID 3106 | -------- Summary: end -------- 03:20:27 INFO - PID 3106 | 03:20:28 INFO - TEST-INFO | 3106: exit 0 03:20:28 INFO - TEST-OK | kraken | took 64219ms 03:20:28 INFO - SUITE-END | took 1187s 03:20:29 INFO - Completed test suite (00:19:47) 03:20:29 INFO - javascript benchmark 03:20:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6619.308763493476, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2707.0795929384008, 2728.4406696627193, 2763.778897688184, 2772.861356932153, 2779.5552711566147, 5042.974785126069, 5178.197379406189, 5181.119209734345, 5214.009338225735, 5242.449542798004, 5195.298634684316, 5207.192885102806, 5274.393444753854, 5283.365996080466, 5321.866953326169, 4346.826126954918, 4559.042601053783, 4620.122176786408, 4643.279620664627, 4722.50413706561, 4656.138614356355, 4672.766361681919, 4676.228422310314, 4693.7653117344, 4703.459102203256, 4540.387047748544, 4560.817567297304, 4561.996360800652, 4562.817487300504, 4569.6801223914335, 4620.052889157714, 4621.607163391116, 4626.190416677102, 4633.62930965522, 4638.466576343696, 4567.6574256930535, 4587.334836448729, 4591.977040114778, 4597.7011494252765, 4606.101810147023, 5007.098722229997, 5074.188129899198, 5076.746162691888, 5094.872628184288, 5100.668456550312, 5641.943580564182, 5647.322321321427, 5669.121286200604, 5697.344805347397, 5699.458551437607, 5623.606347555673, 5667.319921609434, 5669.149627555858, 5683.9715801420725, 5693.231413759131, 5198.090334191501, 5220.504052115081, 5280.20796880471, 5283.181106928432, 5330.333708286465, 5787.971060144757, 5807.157962095557, 5909.0, 5920.2007728956905, 5920.615160014585, 5409.83770486886, 5417.6478528895495, 5502.257195278667, 5503.587230957694, 5504.779808807602, 5711.514521265739, 5713.457221563945, 5714.971425142848, 5716.399778023331, 5756.65460072397, 5645.661260324394, 5658.943410565924, 5662.0, 5662.745176467069, 5669.914951275734, 5522.806701765419, 5568.805091821848, 5613.270274864241, 5622.072358060956, 5655.858603534944, 4734.100520901018, 4735.100330937111, 4735.12400205963, 4778.092162489116, 4783.091212669582, 4026.0941288210506, 4028.1742242840733, 4031.5968403160036, 4039.6768258539246, 4070.4911886014247, 4734.029523947583, 4748.382710247645, 4797.664163508521, 4837.830675926326, 4881.536254055859, 5596.692181929951, 5652.378238393773, 5665.716714164275, 5674.06377947634, 5700.3444603871085, 4768.785404656799, 4800.4479484859685, 4813.133635945494, 4814.566688997937, 4861.854144375674, 4932.457429682732, 5020.246962955513, 5034.471380504994, 5038.118329292359, 5038.445770965191, 5235.293235413171, 5314.256004159343, 5337.919931201112, 5339.25250464943, 5341.5459685927135, 5702.0306547887785, 5703.173039909273, 5722.971385143048, 5734.025215713255, 5755.395683453177, 5282.603804714585, 5287.947120528899, 5293.417724050429, 5294.523492885659, 5296.3379577552805, 5466.371367292653, 5599.832005039855, 5600.0, 5602.439756024528, 5650.3219613646625, 5556.666600004012, 5611.831645050655, 5615.494605485526, 5642.322921249476, 5664.745086471036, 5365.651232669864, 5444.428335024765, 5513.862153446196, 5517.034518959086, 5521.309836270466, 5471.72641367938, 5535.7785688572, 5538.252335934597, 5565.833025009256, 5580.2466666999435, 5452.91820622683, 5453.045716999589, 5453.291072160594, 5466.508014278734, 5470.398256191896, 5417.079096553674, 5533.391326954113, 5537.723113844372, 5539.196816461671, 5540.0, 5358.7320633967365, 5386.192071189353, 5387.595930305164, 5387.730613469233, 5389.083855744454], "value": 5111.660621496571, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [683.8700646877093, 734.2217249715302, 752.9472936894418, 1088.1403691084045, 1099.2525082943596, 25574.488510229807, 26187.86906065467, 26214.0, 26224.0, 29546.40907181855, 33924.83037584815, 34113.65886341136, 34336.82831585839, 34424.65575344246, 34433.65566344336, 6777.59334439934, 6926.757563485279, 6928.965355173217, 6932.757353492629, 6935.167779866423, 5213.6089793265655, 5385.623006389555, 6862.862742745142, 6956.304369563029, 6966.094407726989, 6730.293319201487, 6910.032595436643, 6911.481638877104, 6926.37662610365, 6926.965365173192, 6896.896546551806, 6953.826154346131, 6957.652117394161, 6960.617166055865, 6962.651867406609, 5176.870578235536, 5331.893362132774, 6788.321167883221, 6872.553284036571, 6873.931260687429, 28996.27509312263, 29722.0, 29776.404471910657, 29867.850660746775, 29921.700782992328, 3030.424219398329, 3084.0, 3084.0593618946214, 3084.15185823898, 3085.3674996625864, 23727.644085338732, 23749.643755343684, 23806.28581142551, 23811.642825357634, 23823.16618918347, 3126.296583268769, 3134.9373012539622, 3148.275896543808, 3165.0030240474175, 3167.04988503448, 139547.0, 139616.0, 139618.0, 140297.0, 141886.2905685465, 40372.596274037474, 40408.0, 40463.0, 40465.79767101146, 40484.39273410901, 42593.14813703771, 42667.57332426698, 42683.57316426796, 42726.57273427226, 42730.0, 12926.612201633967, 13064.738705225842, 13072.673183170496, 13089.149205301625, 13106.60680179596, 10672.679819605424, 10687.358758474516, 10714.839277410845, 10720.195985301134, 10742.94628526868, 9990.400575965465, 10222.080012798735, 10252.23108266883, 11309.830352544719, 11688.298702077733, 4448.621867141329, 5382.407935127133, 5569.805056822992, 5575.414581468968, 5649.237352957381, 885.3669626217286, 920.7145784806731, 931.189864817613, 933.4119504711988, 949.1030975728008, 20866.0, 21872.45318867041, 21887.233946811786, 21974.670379944313, 21976.780232197794, 998.4308943901906, 1000.7348052766023, 1014.4724743133529, 1027.465717826726, 1027.5170669785189, 10421.89327229652, 11188.720281993015, 11306.208565400508, 11334.093272538343, 11485.310881347146, 174544.1272793628, 174906.0, 175798.0, 176189.0, 176554.0, 40630.0, 41108.1778364431, 41169.382459263135, 41312.79343603323, 41314.1737165261, 1218.8598311194326, 1254.6486983644595, 1260.3572178189006, 1265.6013355792895, 1271.4723389793317, 19133.904330478257, 19569.412917612495, 20533.691994619792, 20739.8963005184, 20957.1617135319, 29125.85437072801, 29255.414891702472, 29261.41477170402, 29264.56103158412, 29276.0, 139812.30093849465, 139826.30086849502, 140781.0, 141135.29432352772, 141142.2942885279, 29559.408811824072, 29660.258493537833, 29802.0, 29855.0, 29885.252868678457, 28296.85851570729, 31598.842005789826, 32856.83571582127, 35233.47149792806, 35296.47055294224, 24609.63085553754, 25372.492550148523, 26083.08709195169, 26210.475790483702, 27289.727102728717, 25985.0, 26094.73905260923, 26529.734702652728, 26588.0, 27225.230360026533, 27369.589456157777, 28271.29321766972, 28403.857980709963, 28467.00365487198, 28645.14064578066, 24599.508009839345, 24635.753642463347, 24854.254372368858, 25429.61855572205, 26192.476150477265, 21465.864254115346, 22822.885885570468, 22875.428114297276, 23098.076076956735, 23138.190163344203], "value": 14119.595414423075, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.9073822282653, 404.18556608433994, 417.2322925816497, 425.33010508449195, 426.3902619254465, 12017.098717596182, 13754.0, 17605.0, 18141.183646735895, 18409.44771656851, 17446.38937637183, 17496.300147994065, 17863.55341116473, 17900.910495447504, 18301.90849045756, 5346.572274218072, 5521.337439507265, 5523.585731070166, 5525.696086715229, 5525.723713814314, 5310.522053015228, 5330.520253177213, 5446.863828404302, 5471.06991811393, 5473.452654734515, 5415.675059496423, 5446.183072539111, 5451.127819548873, 5452.563794896419, 5458.9454105459035, 5235.633505654587, 5437.075697131497, 5457.154141108134, 5493.395726470085, 5498.642588231792, 4917.704937703714, 4965.0, 4967.751612419364, 4967.751612419401, 4971.900561988776, 20969.266075687432, 21015.159393624235, 21146.3656090316, 21157.365279041653, 21178.682319765063, 1646.3414634146436, 1675.7821483207226, 1703.957401064971, 1704.463094125359, 1705.0622157813152, 13808.516701915385, 13876.930615346959, 13892.0, 13955.302234888215, 14218.360173792204, 1876.4370688793308, 1890.6880364739802, 1914.5117994911209, 1916.089857317777, 1948.298612499499, 69073.0, 76400.61799691021, 91475.0, 91852.54073729656, 93258.0, 10780.730481738019, 10811.243212975174, 10999.450027498753, 11096.0, 11299.20905536621, 15236.162011089496, 15278.0, 15306.311215995307, 15419.768703469457, 15441.691166176613, 6998.230194678581, 6998.860022799516, 7150.141982962078, 7322.890156647654, 7333.88999165013, 6405.839854003687, 6498.642574658439, 6585.0, 6588.835279117964, 6647.833804154935, 6864.279250678706, 7030.437564994788, 7064.823379415453, 7121.0, 7182.7486037989465, 1952.160570954503, 1983.4545499987619, 2022.322521955132, 2040.6530889748778, 2071.3682326890143, 899.4917871402637, 918.3204428722697, 919.3426699909596, 932.1517419148543, 955.9808803823885, 16513.256903439375, 17251.913740431217, 17272.22274997628, 17288.481345559652, 17461.0, 911.2026976395654, 914.5244472874068, 930.3487558708931, 936.5270538378212, 940.2524992630875, 8930.776730581787, 9230.215431688248, 9587.712368628952, 9598.66404675833, 9729.4648794317, 332171.0, 338460.0, 340242.0, 341567.0, 341856.0, 60995.0, 76537.0, 76933.0, 76949.2305076942, 77874.0, 1094.3543309447464, 1112.9276597021167, 1123.5505797680994, 1145.2613064573304, 1148.3798748675622, 16872.0, 16890.324387024873, 17258.482245532654, 18097.18562664657, 18218.45344639663, 36806.63193368032, 38232.80883595564, 38778.642747503705, 38873.0, 39506.40740388839, 45268.77365613283, 46079.3088103672, 47645.0, 48206.0, 48610.27084593663, 8049.959750201211, 8082.878756818534, 8447.281981031681, 8508.532030738368, 8576.228139467477, 12923.0, 13163.60509184726, 13292.867071329163, 13301.800472993107, 13593.116447430886, 10925.125989920629, 10989.780204395707, 11133.944330278297, 11462.197646165023, 11543.307401555934, 10765.138788897026, 10911.890881091087, 11006.669799906016, 11038.951299626522, 11110.000099991039, 10966.342019478856, 11088.168387370819, 11113.833292500458, 11355.943220283845, 11543.134264929995, 7986.361091112581, 8138.0, 8158.469699469515, 8168.7957801055445, 8225.136360682282, 11034.393108379116, 11223.326600404002, 11232.550697972316, 11282.097432205239, 11731.41342932867], "value": 8743.3406419709, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1262.741138066696, 1285.749278890616, 1319.881210691038, 1328.3424704771135, 1334.4711771193595, 9737.1236588707, 10242.385456872593, 10243.180545556355, 10244.385336879792, 10253.538590763415, 9872.555734991925, 10003.49982500874, 10356.119729822974, 10367.948160259208, 10401.479926003689, 2225.043231410497, 2261.118163916074, 2262.2195342606774, 2263.1400067974146, 2267.841251112423, 2110.7256056712604, 2226.2875879718495, 2226.92205772798, 2227.487677834099, 2232.854864433815, 1773.991130044348, 1837.9264829406807, 2136.220279597951, 2200.3618950504333, 2205.8014778669917, 2221.0671517962496, 2239.3393948785147, 2240.19353032908, 2245.584566855137, 2248.5053288276717, 2146.1308170191096, 2185.0385830234645, 2186.9015894284794, 2192.1669765489014, 2196.901139448729, 9706.757331066709, 9897.4556399398, 9914.107730304235, 9944.701658950244, 9956.502174891299, 5549.445055494418, 5727.541796656299, 5744.540436765049, 5770.278715160605, 5774.913376299359, 3343.3647606954846, 3514.771539849927, 3558.323918455511, 3560.9109772255642, 3571.482135090397, 1048.7849990751877, 1052.489542571852, 1096.2107282756403, 1115.6820306212771, 1123.5730422439503, 14593.270336483134, 14726.484573039892, 14730.410783568645, 14730.926345368205, 14744.926275368554, 4563.338315944236, 4668.906621867612, 4792.976035119872, 4887.437944636341, 4932.457429682732, 10971.615993440191, 10971.670849874517, 10979.28634638746, 10981.890181098086, 10989.6153634624, 5491.368492623399, 5546.057170281062, 5559.777608895599, 5574.554035677136, 5582.7766889324785, 5205.765740541685, 5230.529252367229, 5251.789928402897, 5301.443348448434, 5312.2297266896085, 3696.6857817085847, 3775.3581891078584, 3783.5838057813617, 3812.923741525154, 3890.299746045739, 1080.400377790334, 1088.0914436445498, 1097.401915955806, 1105.3865104866877, 1106.8858480302583, 695.9304069593001, 717.6160753996587, 717.9605121718251, 719.1406269507888, 731.5281643340122, 5231.450697676689, 5243.213517972335, 5343.038253114477, 5393.083175860113, 5401.351837779492, 549.5576061270635, 563.374654133911, 564.624524691084, 564.8983183027094, 565.9236003139606, 3355.4295769719206, 3363.83180840957, 3381.9492707609406, 3386.1196089017035, 3490.8254587270535, 11585.420728963687, 11882.940585297018, 12007.0, 12044.21712588679, 12045.277283363026, 11994.460249288803, 11994.520219191134, 11997.460114294878, 12000.459979300953, 12010.099242556844, 6977.33715297046, 7217.639118044077, 7226.349628533457, 7292.489525733148, 7323.560586364835, 5564.137558678412, 5577.6653400796085, 5615.241942337895, 5628.324601047901, 5864.882702346014, 10457.477126143815, 10464.581416743245, 10501.422421766876, 10521.684349469528, 10568.20738444635, 10875.619353322596, 10894.891051089387, 11009.559617615527, 11123.72190695239, 11134.0, 6950.687219075053, 7106.538075025107, 7106.857862842611, 7108.537945033556, 7632.847343052997, 9791.902080979384, 9837.0, 9928.801423971336, 9929.3545919515, 9930.304878658424, 8283.917160828314, 8289.875651865348, 8393.748187554384, 8415.368847336353, 8678.78303042429, 7628.46600737943, 8063.919360806317, 8117.553534555656, 8130.796730081795, 8331.50010999342, 7345.412367010733, 7512.32389084985, 7513.624318784148, 7519.285667861544, 7537.095548534211, 5243.501867322599, 5249.2126181073145, 5255.185446255837, 5290.809567847357, 5470.206820011155, 5254.474552544868, 5383.031054410088, 5418.0, 5460.716731567999, 5500.037493438552], "value": 4592.174310329732, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.7846756543377, 359.4751662572644, 388.5065966222897, 391.49497148678205, 396.668781567391, 4744.217204161314, 5355.973220133898, 5361.437049109846, 5366.168243922199, 5366.785328586851, 5158.742062896849, 5244.423113457517, 5272.446393128724, 5281.445448227938, 5323.653962492435, 4033.7176397652174, 4117.876463706094, 4200.558941311172, 4201.222773786859, 4203.5165955915, 4095.5290141633795, 4206.516250631186, 4214.325707886739, 4217.578242175789, 4219.493660760713, 4179.435776170209, 4188.931822385288, 4189.476315460567, 4191.308434108369, 4204.306289462251, 3989.581093985119, 4012.6789856811383, 4192.643625291838, 4203.054312779631, 4205.621494065549, 3809.142942837867, 3810.5236845394325, 3823.541175058983, 3855.74937629056, 3860.0, 5086.516780905808, 5091.109055915237, 5110.514501122388, 5112.054269960069, 5124.154514505102, 4827.548302963398, 4930.359053323081, 4939.481354457766, 4947.50524947506, 4987.476314986947, 5575.944240557583, 5597.076482380402, 5600.971995140039, 5632.183333416631, 5632.831015069554, 4293.978530107361, 4296.0, 4297.097609502009, 4304.461942257218, 4312.159128969852, 5785.27684039495, 5877.235959325346, 5897.823065308047, 5963.314218864843, 5997.940020599782, 4426.468823741172, 4433.202023635777, 4438.933415998763, 4444.955550444519, 4445.444319460003, 4270.252705776476, 4499.482559505699, 4503.0, 4509.706869053501, 4515.367848501212, 4766.666333356701, 4852.4662287148385, 4934.851954441372, 4937.728424936663, 4962.230854217602, 5596.38439771633, 5632.4930756231315, 5633.661980281115, 5636.210930469738, 5657.377688454267, 1514.5759187427318, 1561.0399604243535, 1561.110167204705, 1561.5315405378342, 1570.7957965464416, 1119.7032786311634, 1129.2045647420641, 1140.401289323112, 1147.145376694368, 1148.9770204595861, 4891.95108048915, 4930.728809915489, 4937.950620493749, 4942.9258561121615, 4947.65366424354, 5815.767369305265, 5825.553107844179, 5832.854178645568, 5833.4749872511675, 5838.357780644125, 4800.591949684246, 4885.267209918469, 4901.828436004723, 4937.259411088366, 4943.615787579483, 3022.1084779989956, 3030.166749116797, 3049.7255247027874, 3054.1601059708314, 3058.4494790937847, 5412.107002344648, 5418.8916221675345, 5430.8099216527235, 5431.511163995259, 5444.91832622511, 5759.798407055733, 5852.8536786579825, 5890.2342695449315, 5912.556558258148, 5918.940810591839, 5352.732363381815, 5360.088784906575, 5371.194320851903, 5375.274337964403, 5377.193420986883, 5650.434956504317, 5675.77296908119, 5691.430856914441, 5716.485516303553, 5717.1995920570325, 5628.409017053151, 5641.971790141023, 5646.689432081275, 5671.773129074791, 5684.9431505684415, 5346.572274218131, 5365.061114305059, 5370.140777475585, 5370.704611246263, 5380.300560927054, 4358.237308470942, 4414.095110502275, 4443.311286750559, 4448.5551444855255, 4462.888427789331, 5479.397266300624, 5575.721213939206, 5631.465010823965, 5704.144378343116, 5715.371309155907, 5550.250716153268, 5562.388137304974, 5563.221149039218, 5577.749001295033, 5587.832365029056, 5414.458554144554, 5519.972400138135, 5527.640703354269, 5554.666719996813, 5558.082916318924, 5495.835124946258, 5504.311961004874, 5504.889902202013, 5519.172124181405, 5519.227308176939, 5581.967336042845, 5608.10270356741, 5609.27079479665, 5614.52276556481, 5632.887667124828, 5298.841034768809, 5415.214793854948, 5454.127339625641, 5454.618176727591, 5474.835754927359], "value": 4304.965514654083, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [752.8293503601897, 763.3931024835257, 776.9961150194248, 777.0325944199469, 780.1730166024013, 12646.873531264684, 13184.93407532961, 13185.538506152287, 13198.340082995848, 13225.272610006457, 13250.07249492536, 14960.850391496082, 15401.460948866792, 15542.378304867792, 15543.84456155441, 905.8188362327528, 923.5243849417556, 923.7321176858736, 924.8289066522681, 927.0914503786294, 931.3434029009566, 934.0705997532465, 934.2059249637822, 935.1209862729013, 935.8783358163429, 986.5215370545316, 989.2284018465608, 991.5984026469256, 991.8462638291077, 992.2161492420979, 944.3625552751865, 959.0457494792726, 964.9758756031085, 977.2426369563609, 983.1692220074026, 709.3899246647878, 712.3161764705836, 713.20477667401, 713.960732159731, 714.3749219432996, 13359.53241636538, 13570.050096493249, 13617.727645447134, 13626.659333516642, 13672.794908076386, 15068.0, 15098.622534436618, 15121.395144194219, 15207.923960380238, 15282.465113721077, 11549.826752598718, 12009.699757506045, 12033.699157521045, 12034.277943323428, 12075.456604452733, 2841.3606938438893, 2858.4854726149492, 2882.6396700412447, 2905.8111222770663, 2908.8836446542114, 62632.37367626357, 63053.684731576046, 69102.65448672725, 69224.6538767303, 69872.30127698708, 11575.0, 11797.29216247028, 11856.407179640983, 11863.644090677293, 11866.466009029615, 21310.78689213088, 21451.356459305935, 21750.0, 21924.342269731933, 22014.88992555027, 5672.688002159921, 5840.853978650568, 5850.5904586678525, 5853.09277062056, 5857.26784151981, 3018.2756138526597, 3077.92305192372, 3084.259777653347, 3090.258337998909, 3091.984540077285, 3313.6686331366673, 3373.241020770307, 3399.9150021249666, 3406.489026646023, 3410.471376936579, 742.3652776875801, 763.2596381509926, 781.7615627233635, 781.9218078192135, 783.3576467296875, 551.37323612534, 594.5035895027614, 607.113614123376, 608.9756409743561, 622.5206590924962, 8789.560521973875, 9314.0, 10108.797824043479, 10414.427206503564, 10799.56801727922, 572.9942700573024, 578.0664227272924, 578.7222133375919, 579.7333226715758, 598.6138940383428, 4353.521112677603, 4431.667624928144, 4434.17967675981, 4470.485894122153, 4470.619997300266, 58884.705576471846, 60938.0859287111, 61871.690641546506, 62318.688406557674, 62540.06189907155, 54903.450965490636, 55552.0, 55672.72163639156, 55696.16455753167, 55897.16154257689, 35893.46159807605, 47129.76435117871, 48690.75654621704, 48807.51192488101, 49671.751641241564, 9991.950845161153, 10158.542865570918, 10403.219758518293, 10410.375377477072, 10459.372437653765, 24909.875450622632, 25294.873525632254, 25323.49353012966, 25708.228753137435, 25914.35214119662, 30131.698683012888, 42965.355519666606, 43770.343444848986, 45022.77488612536, 45819.77090114528, 13805.309734513034, 14035.578932632037, 14226.217558034408, 14358.784618230526, 14375.065620734618, 13653.044286899822, 14046.648833779238, 14343.354549045109, 14401.927990359982, 14789.556313310617, 13606.591802245948, 13842.238676872868, 14080.78878816798, 14118.717625647634, 14367.85632143707, 12559.93720031394, 12941.158824676366, 12999.0, 13821.239831809347, 13976.860231397555, 12376.62870113898, 12903.161294515827, 13243.0, 13244.801327979896, 13599.932000339935, 9636.46999415011, 9929.404235745878, 9940.850887236842, 10096.293259471766, 10988.560457581607, 10436.739081522719, 10443.06012458852, 10679.786404271716, 10783.460826958464, 11043.83434248503], "value": 6742.089941160473, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1507.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 111.0, 111.0, 110.0, 110.0, 111.0, 110.0, 110.0, 111.0, 111.0], "value": 110.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 121.0, 121.0, 175.0, 121.0, 121.0, 119.0, 126.0, 150.0, 122.0], "value": 132.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 164.0, 162.0, 162.0, 161.0, 163.0, 161.0, 163.0, 161.0], "value": 161.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 75.0, 76.0, 108.0, 75.0, 76.0, 73.0, 74.0, 94.0, 77.0], "value": 80.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 116.0, 84.0, 84.0, 83.0, 99.0, 83.0, 83.0, 109.0], "value": 90.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 113.0, 113.0, 114.0, 113.0, 114.0, 113.0, 113.0, 113.0, 113.0], "value": 113.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 148.0, 148.0, 150.0, 148.0, 148.0, 148.0, 150.0, 149.0], "value": 148.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 94.0, 93.0, 94.0, 93.0, 93.0, 94.0, 93.0], "value": 93.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 52.0, 52.0, 53.0, 53.0, 53.0, 53.0, 52.0, 52.0], "value": 52.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 55.0, 54.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 81.0, 81.0, 82.0, 80.0, 79.0, 80.0, 80.0, 81.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 137.0, 135.0, 126.0, 131.0, 127.0, 128.0, 128.0, 178.0, 125.0], "value": 134.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 185.0, 188.0, 187.0, 187.0, 185.0, 186.0, 187.0, 180.0, 189.0], "value": 185.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 71.0, 68.0, 70.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0], "value": 69.1, "unit": "score"}]}]} 03:20:29 INFO - Return code: 0 03:20:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 03:20:29 INFO - # TBPL SUCCESS # 03:20:29 INFO - Running post-action listener: _resource_record_post_action 03:20:29 INFO - [mozharness: 2017-05-04 10:20:29.353317Z] Finished run-tests step (success) 03:20:29 INFO - Running post-run listener: _resource_record_post_run 03:20:29 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 12288; Write bytes: 348016640; Read time: 140; Write time: 354416 03:20:29 INFO - TinderboxPrint: CPU usage
13.0% 03:20:29 INFO - TinderboxPrint: I/O read bytes / time
12,288 / 140 03:20:29 INFO - TinderboxPrint: I/O write bytes / time
348,016,640 / 354,416 03:20:29 INFO - TinderboxPrint: CPU idle
8,357.0 (87.0%) 03:20:29 INFO - TinderboxPrint: CPU user
1,200.3 (12.5%) 03:20:29 INFO - TinderboxPrint: Swap in / out
0 / 0 03:20:29 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 4096; Write bytes: 33406976; Read time: 28; Write time: 9512 03:20:29 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 4096; Write bytes: 244723712; Read time: 88; Write time: 230948 03:20:29 INFO - Running post-run listener: _upload_blobber_files 03:20:29 INFO - Blob upload gear active. 03:20:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:20:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 03:20:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 03:20:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 03:20:30 INFO - (blobuploader) - INFO - Open directory for files ... 03:20:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 03:20:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 03:20:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:33 INFO - (blobuploader) - INFO - Done attempting. 03:20:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 03:20:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 03:20:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:34 INFO - (blobuploader) - INFO - Done attempting. 03:20:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 03:20:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:36 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 03:20:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:36 INFO - (blobuploader) - INFO - Done attempting. 03:20:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 03:20:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:20:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:20:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 03:20:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:20:36 INFO - (blobuploader) - INFO - Done attempting. 03:20:36 INFO - (blobuploader) - INFO - Iteration through files over. 03:20:36 INFO - Return code: 0 03:20:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:20:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:20:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23ae5dfbf0712f784d65196fc52252868195c5f1b915fc36c0d073e61eccc699472998172f71b414944bf4ace211e368302d8425ee1efbde77d81684b8400311", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7d2367923b60b430742f0833594f3b3d7a5587d2b72944c541c3a2014149dc8b50f886088a2676bc469ba36ace404af5a50ae157ff317fa96b071671895c89a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f5787dcd9fc5acaa2a620bb972d97130a2b1e45d5abbc8c97ac1656122b88c9ba945ab803bcc107924cbe63cbdf19a7b84087b6a07faeee1f62154db8897be9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac463ffeb41e7fd0dd8cba538a986f8361dab872cd6b38d21ef8d9b162632fa9f6135cb6bfca82a7aefef4814e15e3bf647f6a04ea59b3f691ea828e049a7891"} 03:20:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:20:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:20:36 INFO - Contents: 03:20:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23ae5dfbf0712f784d65196fc52252868195c5f1b915fc36c0d073e61eccc699472998172f71b414944bf4ace211e368302d8425ee1efbde77d81684b8400311", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7d2367923b60b430742f0833594f3b3d7a5587d2b72944c541c3a2014149dc8b50f886088a2676bc469ba36ace404af5a50ae157ff317fa96b071671895c89a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f5787dcd9fc5acaa2a620bb972d97130a2b1e45d5abbc8c97ac1656122b88c9ba945ab803bcc107924cbe63cbdf19a7b84087b6a07faeee1f62154db8897be9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac463ffeb41e7fd0dd8cba538a986f8361dab872cd6b38d21ef8d9b162632fa9f6135cb6bfca82a7aefef4814e15e3bf647f6a04ea59b3f691ea828e049a7891"} 03:20:36 INFO - Running post-run listener: copy_logs_to_upload_dir 03:20:36 INFO - Copying logs to upload dir... 03:20:36 INFO - mkdir: /builds/slave/test/build/upload/logs 03:20:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.833838 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-05-04 03:20:35.871968) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 03:20:35.876757) ========= 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=fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23ae5dfbf0712f784d65196fc52252868195c5f1b915fc36c0d073e61eccc699472998172f71b414944bf4ace211e368302d8425ee1efbde77d81684b8400311", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7d2367923b60b430742f0833594f3b3d7a5587d2b72944c541c3a2014149dc8b50f886088a2676bc469ba36ace404af5a50ae157ff317fa96b071671895c89a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f5787dcd9fc5acaa2a620bb972d97130a2b1e45d5abbc8c97ac1656122b88c9ba945ab803bcc107924cbe63cbdf19a7b84087b6a07faeee1f62154db8897be9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac463ffeb41e7fd0dd8cba538a986f8361dab872cd6b38d21ef8d9b162632fa9f6135cb6bfca82a7aefef4814e15e3bf647f6a04ea59b3f691ea828e049a7891"} build_url:https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/Z-TFwTHbQCifRD3657r75g/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/23ae5dfbf0712f784d65196fc52252868195c5f1b915fc36c0d073e61eccc699472998172f71b414944bf4ace211e368302d8425ee1efbde77d81684b8400311", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d7d2367923b60b430742f0833594f3b3d7a5587d2b72944c541c3a2014149dc8b50f886088a2676bc469ba36ace404af5a50ae157ff317fa96b071671895c89a", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3f5787dcd9fc5acaa2a620bb972d97130a2b1e45d5abbc8c97ac1656122b88c9ba945ab803bcc107924cbe63cbdf19a7b84087b6a07faeee1f62154db8897be9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ac463ffeb41e7fd0dd8cba538a986f8361dab872cd6b38d21ef8d9b162632fa9f6135cb6bfca82a7aefef4814e15e3bf647f6a04ea59b3f691ea828e049a7891"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 03:20:35.905644) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 03:20:35.906097) ========= 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=fa44defc139c4ba8574fe040000001db-1493891734.101493-1310266150 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 03:20:35.987377) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 03:20:35.987807) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 03:20:35.988265) ========= ========= Total master_lag: 0.19 =========