builder: mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s slave: talos-linux64-ix-083 starttime: 1495166791.85 results: success (0) revision: 8e98dab5054dd093a37ba20c62cf0523e484cfbd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-18 21:06:31.852984) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-18 21:06:31.853456) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-18 21:06:31.853733) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-18 21:06:31.918665) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 21:06:31.918999) ========= 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=3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-18 21:06:32-- 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% 225M=0s 2017-05-18 21:06:32 (225 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.254203 ========= master_lag: 0.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 21:06:32.232837) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 21:06:32.233231) ========= 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=3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015264 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 21:06:32.282927) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 21:06:32.283280) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8e98dab5054dd093a37ba20c62cf0523e484cfbd --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 8e98dab5054dd093a37ba20c62cf0523e484cfbd --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=3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-18 21:06:32,342 truncating revision to first 12 chars 2017-05-18 21:06:32,342 Setting DEBUG logging. 2017-05-18 21:06:32,342 attempt 1/10 2017-05-18 21:06:32,343 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8e98dab5054d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-18 21:06:32,797 unpacking tar archive at: mozilla-central-8e98dab5054d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.867739 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 21:06:33.163467) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-18 21:06:33.163793) ========= script_repo_revision: 8e98dab5054dd093a37ba20c62cf0523e484cfbd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-18 21:06:33.164194) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-18 21:06:33.164580) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-18 21:06:33.179494) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-05-18 21:06:33.179897) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:06:33 INFO - MultiFileLogger online at 20170518 21:06:33 in /builds/slave/test 21:06:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 21:06:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:06:33 INFO - {'append_to_log': False, 21:06:33 INFO - 'base_work_dir': '/builds/slave/test', 21:06:33 INFO - 'blob_upload_branch': 'Firefox', 21:06:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:06:33 INFO - 'branch': 'Firefox', 21:06:33 INFO - 'buildbot_json_path': 'buildprops.json', 21:06:33 INFO - 'config_files': ('talos/linux_config.py',), 21:06:33 INFO - 'default_actions': ('clobber', 21:06:33 INFO - 'read-buildbot-config', 21:06:33 INFO - 'download-and-extract', 21:06:33 INFO - 'populate-webroot', 21:06:33 INFO - 'create-virtualenv', 21:06:33 INFO - 'install', 21:06:33 INFO - 'run-tests'), 21:06:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:06:33 INFO - 'download_minidump_stackwalk': True, 21:06:33 INFO - 'download_symbols': 'ondemand', 21:06:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:06:33 INFO - 'tooltool.py': '/tools/tooltool.py', 21:06:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:06:33 INFO - '/tools/misc-python/virtualenv.py')}, 21:06:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:06:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:06:33 INFO - 'gecko_profile': False, 21:06:33 INFO - 'gecko_profile_interval': 0, 21:06:33 INFO - 'installer_path': 'installer.exe', 21:06:33 INFO - 'log_level': 'info', 21:06:33 INFO - 'log_name': 'talos', 21:06:33 INFO - 'log_to_console': True, 21:06:33 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:06:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:06:33 INFO - 'opt_config_files': (), 21:06:33 INFO - 'pip_index': False, 21:06:33 INFO - 'suite': 'dromaeojs-e10s', 21:06:33 INFO - 'system_bits': '32', 21:06:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:06:33 INFO - 'title': 'talos-linux64-ix-083', 21:06:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:06:33 INFO - 'use_talos_json': True, 21:06:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:06:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:06:33 INFO - 'work_dir': 'build'} 21:06:33 INFO - [mozharness: 2017-05-19 04:06:33.438572Z] Running clobber step. 21:06:33 INFO - Running pre-action listener: _resource_record_pre_action 21:06:33 INFO - Running main action method: clobber 21:06:33 INFO - rmtree: /builds/slave/test/build 21:06:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:06:34 INFO - Running post-action listener: _resource_record_post_action 21:06:34 INFO - [mozharness: 2017-05-19 04:06:34.410126Z] Finished clobber step (success) 21:06:34 INFO - [mozharness: 2017-05-19 04:06:34.410227Z] Running read-buildbot-config step. 21:06:34 INFO - Running pre-action listener: _resource_record_pre_action 21:06:34 INFO - Running main action method: read_buildbot_config 21:06:34 INFO - Using buildbot properties: 21:06:34 INFO - { 21:06:34 INFO - "project": "", 21:06:34 INFO - "product": "firefox", 21:06:34 INFO - "who": "ihsiao@mozilla.com", 21:06:34 INFO - "installer_path": "public/build/target.tar.bz2", 21:06:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_stylo_test-dromaeojs-e10s", 21:06:34 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 21:06:34 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo mozilla-central talos dromaeojs-e10s", 21:06:34 INFO - "stage_platform": "linux64-stylo", 21:06:34 INFO - "basedir": "/builds/slave/test", 21:06:34 INFO - "buildnumber": 98, 21:06:34 INFO - "platform": "ubuntu64_hw_stylo", 21:06:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:06:34 INFO - "slavebuilddir": "test", 21:06:34 INFO - "taskId": "dl35oXjoTOekAR2QV37Ehg", 21:06:34 INFO - "branch": "mozilla-central", 21:06:34 INFO - "script_repo_revision": "production", 21:06:34 INFO - "revision": "8e98dab5054dd093a37ba20c62cf0523e484cfbd", 21:06:34 INFO - "slavename": "talos-linux64-ix-083", 21:06:34 INFO - "repo_path": "mozilla-central" 21:06:34 INFO - } 21:06:34 INFO - Finding installer, test and symbols from parent task. 21:06:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dl35oXjoTOekAR2QV37Ehg'}, attempt #1 21:06:34 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dl35oXjoTOekAR2QV37Ehg'}, attempt #1 21:06:35 INFO - Task dependencies: caIWjHJURdmr8ocUbW1IZQ 21:06:35 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ'}, attempt #1 21:06:35 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ/artifacts/public/build/target.tar.bz2 21:06:35 INFO - Set test_url: https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ/artifacts/public/build/test_packages.json 21:06:35 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ/artifacts/public/build/target.crashreporter-symbols.zip 21:06:35 INFO - Running post-action listener: _resource_record_post_action 21:06:35 INFO - [mozharness: 2017-05-19 04:06:35.764761Z] Finished read-buildbot-config step (success) 21:06:35 INFO - [mozharness: 2017-05-19 04:06:35.764982Z] Running download-and-extract step. 21:06:35 INFO - Running pre-action listener: _resource_record_pre_action 21:06:35 INFO - Running main action method: download_and_extract 21:06:35 INFO - mkdir: /builds/slave/test/build/tests 21:06:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:06:35 INFO - trying https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ/artifacts/public/build/target.test_packages.json 21:06:35 INFO - Downloading https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 21:06:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 21:06:36 INFO - Downloaded 986 bytes. 21:06:36 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 21:06:36 INFO - Using the following test package requirements: 21:06:36 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 21:06:36 INFO - u'common': [u'target.common.tests.zip'], 21:06:36 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 21:06:36 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 21:06:36 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 21:06:36 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 21:06:36 INFO - u'mozbase': [u'target.common.tests.zip'], 21:06:36 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 21:06:36 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 21:06:36 INFO - u'web-platform': [u'target.common.tests.zip', 21:06:36 INFO - u'target.web-platform.tests.zip'], 21:06:36 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 21:06:36 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 21:06:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ/artifacts/public/build/target.common.tests.zip 21:06:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:06:36 INFO - Fetch https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ/artifacts/public/build/target.common.tests.zip into memory 21:06:37 INFO - Content-Length response header: 62465475 21:06:37 INFO - Bytes received: 62465475 21:06:48 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 21:06:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ/artifacts/public/build/target.common.tests.zip 21:06:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ/artifacts/public/build/target.common.tests.zip'}, attempt #1 21:06:48 INFO - Fetch https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ/artifacts/public/build/target.common.tests.zip into memory 21:06:49 INFO - Content-Length response header: 62465475 21:06:49 INFO - Bytes received: 62465475 21:07:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ/artifacts/public/build/target.talos.tests.zip 21:07:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ/artifacts/public/build/target.talos.tests.zip'}, attempt #1 21:07:01 INFO - Fetch https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ/artifacts/public/build/target.talos.tests.zip into memory 21:07:02 INFO - Content-Length response header: 14410001 21:07:02 INFO - Bytes received: 14410001 21:07:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:07:02 INFO - trying https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ/artifacts/public/build/target.tar.bz2 21:07:02 INFO - Downloading https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 21:07:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 21:07:03 INFO - Downloaded 59848804 bytes. 21:07:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ/artifacts/public/build/target.tar.bz2 21:07:03 INFO - mkdir: /builds/slave/test/properties 21:07:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:07:03 INFO - Writing to file /builds/slave/test/properties/build_url 21:07:03 INFO - Contents: 21:07:03 INFO - build_url:https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ/artifacts/public/build/target.tar.bz2 21:07:03 INFO - Running post-action listener: _resource_record_post_action 21:07:03 INFO - Running post-action listener: set_extra_try_arguments 21:07:03 INFO - [mozharness: 2017-05-19 04:07:03.522376Z] Finished download-and-extract step (success) 21:07:03 INFO - [mozharness: 2017-05-19 04:07:03.522474Z] Running populate-webroot step. 21:07:03 INFO - Running pre-action listener: _resource_record_pre_action 21:07:03 INFO - Running main action method: populate_webroot 21:07:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:07:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:07:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:07:03 INFO - '--tppagecycles', 21:07:03 INFO - '7'], 21:07:03 INFO - 'tests': ['tsvgm']}}, 21:07:03 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:07:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:07:03 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:07:03 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:07:03 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:07:03 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:07:03 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 21:07:03 INFO - 'talos_options': ['--disable-e10s'], 21:07:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:07:03 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 21:07:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:07:03 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 21:07:03 INFO - 'talos_options': ['--disable-e10s'], 21:07:03 INFO - 'tests': ['damp', 'tps']}, 21:07:03 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 21:07:03 INFO - 'tests': ['damp', 'tps']}, 21:07:03 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:07:03 INFO - 'tests': ['dromaeo_dom']}, 21:07:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:07:03 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:07:03 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 21:07:03 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 21:07:03 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 21:07:03 INFO - 'tests': ['ts_paint', 'tp5o']}, 21:07:03 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:07:03 INFO - 'tests': ['a11yr', 21:07:03 INFO - 'ts_paint', 21:07:03 INFO - 'tpaint', 21:07:03 INFO - 'sessionrestore', 21:07:03 INFO - 'sessionrestore_no_auto_restore', 21:07:03 INFO - 'tabpaint']}, 21:07:03 INFO - 'other-e10s': {'tests': ['a11yr', 21:07:03 INFO - 'ts_paint', 21:07:03 INFO - 'tpaint', 21:07:03 INFO - 'sessionrestore', 21:07:03 INFO - 'sessionrestore_no_auto_restore', 21:07:03 INFO - 'tabpaint']}, 21:07:03 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:07:03 INFO - 'ts_paint', 21:07:03 INFO - 'tpaint', 21:07:03 INFO - 'sessionrestore', 21:07:03 INFO - 'sessionrestore_no_auto_restore', 21:07:03 INFO - 'tabpaint']}, 21:07:03 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:07:03 INFO - 'ts_paint', 21:07:03 INFO - 'tpaint', 21:07:03 INFO - 'sessionrestore', 21:07:03 INFO - 'sessionrestore_no_auto_restore', 21:07:03 INFO - 'tabpaint']}, 21:07:03 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:07:03 INFO - 'tests': ['a11yr', 21:07:03 INFO - 'ts_paint', 21:07:03 INFO - 'tpaint', 21:07:03 INFO - 'sessionrestore', 21:07:03 INFO - 'sessionrestore_no_auto_restore', 21:07:03 INFO - 'tabpaint']}, 21:07:03 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:07:03 INFO - 'tests': ['a11yr', 21:07:03 INFO - 'ts_paint', 21:07:03 INFO - 'tpaint', 21:07:03 INFO - 'sessionrestore', 21:07:03 INFO - 'sessionrestore_no_auto_restore', 21:07:03 INFO - 'tabpaint']}, 21:07:03 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 21:07:03 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 21:07:03 INFO - 'bloom_basic_ref']}, 21:07:03 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:07:03 INFO - 'tests': ['tsvgx', 21:07:03 INFO - 'tsvgr_opacity', 21:07:03 INFO - 'tart', 21:07:03 INFO - 'tscrollx', 21:07:03 INFO - 'cart', 21:07:03 INFO - 'tsvg_static']}, 21:07:03 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:07:03 INFO - 'tsvgr_opacity', 21:07:03 INFO - 'tart', 21:07:03 INFO - 'tscrollx', 21:07:03 INFO - 'cart', 21:07:03 INFO - 'tsvg_static']}, 21:07:03 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 21:07:03 INFO - 'talos_options': ['--disable-e10s'], 21:07:03 INFO - 'tests': ['tp5o']}, 21:07:03 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 21:07:03 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 21:07:03 INFO - 'talos_options': ['--disable-e10s', 21:07:03 INFO - '--xperf_path', 21:07:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:07:03 INFO - 'tests': ['tp5n']}, 21:07:03 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 21:07:03 INFO - 'talos_options': ['--xperf_path', 21:07:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:07:03 INFO - 'tests': ['tp5n']}}, 21:07:03 INFO - 'talos.zip': {'path': '', 21:07:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:07:03 INFO - Running post-action listener: _resource_record_post_action 21:07:03 INFO - [mozharness: 2017-05-19 04:07:03.536576Z] Finished populate-webroot step (success) 21:07:03 INFO - [mozharness: 2017-05-19 04:07:03.536665Z] Running create-virtualenv step. 21:07:03 INFO - Running pre-action listener: _resource_record_pre_action 21:07:03 INFO - Running main action method: create_virtualenv 21:07:03 INFO - Creating virtualenv /builds/slave/test/build/venv 21:07:03 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 21:07:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:07:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:07:03 INFO - Using real prefix '/usr' 21:07:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:07:04 INFO - Installing distribute.............................................................................................................................................................................................done. 21:07:06 INFO - Installing pip.................done. 21:07:06 INFO - Return code: 0 21:07:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:07:06 INFO - Reading from file tmpfile_stdout 21:07:06 INFO - Output received: 21:07:06 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) 21:07:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:06 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/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 0xb031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe765c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe737a0>, '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 0xe746a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe74b30>, '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': '3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797', '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 21:07:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 21:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:07:06 INFO - Using env: {'DISPLAY': ':0', 21:07:06 INFO - 'HOME': '/home/cltbld', 21:07:06 INFO - 'LANG': 'en_US.UTF-8', 21:07:06 INFO - 'LANGUAGE': 'en_US:en', 21:07:06 INFO - 'LOGNAME': 'cltbld', 21:07:06 INFO - 'MAIL': '/var/mail/cltbld', 21:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:06 INFO - 'MOZ_NO_REMOTE': '1', 21:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:07:06 INFO - 'NO_EM_RESTART': '1', 21:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:06 INFO - 'PWD': '/builds/slave/test', 21:07:06 INFO - 'SHELL': '/bin/bash', 21:07:06 INFO - 'SHLVL': '1', 21:07:06 INFO - 'TERM': 'linux', 21:07:06 INFO - 'TMOUT': '86400', 21:07:06 INFO - 'USER': 'cltbld', 21:07:06 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797', 21:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:06 INFO - '_': '/tools/buildbot/bin/python'} 21:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:06 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 21:07:06 INFO - Cleaning up... 21:07:06 INFO - Return code: 0 21:07:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:06 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/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 0xb031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe765c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe737a0>, '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 0xe746a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe74b30>, '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': '3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797', '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 21:07:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 21:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:07:06 INFO - Using env: {'DISPLAY': ':0', 21:07:06 INFO - 'HOME': '/home/cltbld', 21:07:06 INFO - 'LANG': 'en_US.UTF-8', 21:07:06 INFO - 'LANGUAGE': 'en_US:en', 21:07:06 INFO - 'LOGNAME': 'cltbld', 21:07:06 INFO - 'MAIL': '/var/mail/cltbld', 21:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:06 INFO - 'MOZ_NO_REMOTE': '1', 21:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:07:06 INFO - 'NO_EM_RESTART': '1', 21:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:06 INFO - 'PWD': '/builds/slave/test', 21:07:06 INFO - 'SHELL': '/bin/bash', 21:07:06 INFO - 'SHLVL': '1', 21:07:06 INFO - 'TERM': 'linux', 21:07:06 INFO - 'TMOUT': '86400', 21:07:06 INFO - 'USER': 'cltbld', 21:07:06 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797', 21:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:06 INFO - '_': '/tools/buildbot/bin/python'} 21:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:06 INFO - Downloading/unpacking psutil>=3.1.1 21:07:06 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 21:07:06 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 21:07:06 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 21:07:06 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 21:07:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:07:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:07:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:07:08 INFO - Installing collected packages: psutil 21:07:08 INFO - Running setup.py install for psutil 21:07:08 INFO - building 'psutil._psutil_linux' extension 21:07:08 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 21:07:09 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 21:07:09 INFO - building 'psutil._psutil_posix' extension 21:07:09 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 21:07:09 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 21:07:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:07:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:07:09 INFO - Successfully installed psutil 21:07:09 INFO - Cleaning up... 21:07:09 INFO - Return code: 0 21:07:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xb031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe765c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe737a0>, '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 0xe746a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe74b30>, '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': '3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797', '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 21:07:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 21:07:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 21:07:09 INFO - Using env: {'DISPLAY': ':0', 21:07:09 INFO - 'HOME': '/home/cltbld', 21:07:09 INFO - 'LANG': 'en_US.UTF-8', 21:07:09 INFO - 'LANGUAGE': 'en_US:en', 21:07:09 INFO - 'LOGNAME': 'cltbld', 21:07:09 INFO - 'MAIL': '/var/mail/cltbld', 21:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:09 INFO - 'MOZ_NO_REMOTE': '1', 21:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:07:09 INFO - 'NO_EM_RESTART': '1', 21:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:09 INFO - 'PWD': '/builds/slave/test', 21:07:09 INFO - 'SHELL': '/bin/bash', 21:07:09 INFO - 'SHLVL': '1', 21:07:09 INFO - 'TERM': 'linux', 21:07:09 INFO - 'TMOUT': '86400', 21:07:09 INFO - 'USER': 'cltbld', 21:07:09 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797', 21:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:09 INFO - '_': '/tools/buildbot/bin/python'} 21:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:07:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:07:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:07:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:07:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:07:10 INFO - Installing collected packages: mozsystemmonitor 21:07:10 INFO - Running setup.py install for mozsystemmonitor 21:07:10 INFO - Successfully installed mozsystemmonitor 21:07:10 INFO - Cleaning up... 21:07:10 INFO - Return code: 0 21:07:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:07:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:07:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07: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/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 0xb031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe765c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe737a0>, '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 0xe746a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe74b30>, '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': '3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797', '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 21:07:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 21:07:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:07:10 INFO - Using env: {'DISPLAY': ':0', 21:07:10 INFO - 'HOME': '/home/cltbld', 21:07:10 INFO - 'LANG': 'en_US.UTF-8', 21:07:10 INFO - 'LANGUAGE': 'en_US:en', 21:07:10 INFO - 'LOGNAME': 'cltbld', 21:07:10 INFO - 'MAIL': '/var/mail/cltbld', 21:07:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:10 INFO - 'MOZ_NO_REMOTE': '1', 21:07:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:07:10 INFO - 'NO_EM_RESTART': '1', 21:07:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:07:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:10 INFO - 'PWD': '/builds/slave/test', 21:07:10 INFO - 'SHELL': '/bin/bash', 21:07:10 INFO - 'SHLVL': '1', 21:07:10 INFO - 'TERM': 'linux', 21:07:10 INFO - 'TMOUT': '86400', 21:07:10 INFO - 'USER': 'cltbld', 21:07:10 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797', 21:07:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:10 INFO - '_': '/tools/buildbot/bin/python'} 21:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:11 INFO - Downloading/unpacking jsonschema==2.5.1 21:07: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 21:07: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 21:07: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 21:07: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 21:07:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:07:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:07:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:07:12 INFO - Downloading functools32-3.2.3-2.tar.gz 21:07:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:07:12 INFO - warning: no files found matching '*.txt' 21:07:12 INFO - no previously-included directories found matching 'build' 21:07:12 INFO - no previously-included directories found matching 'dist' 21:07:12 INFO - no previously-included directories found matching '.git*' 21:07:12 INFO - Installing collected packages: jsonschema, functools32 21:07:12 INFO - Running setup.py install for functools32 21:07:12 INFO - warning: no files found matching '*.txt' 21:07:12 INFO - no previously-included directories found matching 'build' 21:07:12 INFO - no previously-included directories found matching 'dist' 21:07:12 INFO - no previously-included directories found matching '.git*' 21:07:12 INFO - Successfully installed jsonschema functools32 21:07:12 INFO - Cleaning up... 21:07:12 INFO - Return code: 0 21:07:12 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xb031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe765c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe737a0>, '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 0xe746a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe74b30>, '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': '3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797', '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 21:07:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 21:07:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 21:07:12 INFO - Using env: {'DISPLAY': ':0', 21:07:12 INFO - 'HOME': '/home/cltbld', 21:07:12 INFO - 'LANG': 'en_US.UTF-8', 21:07:12 INFO - 'LANGUAGE': 'en_US:en', 21:07:12 INFO - 'LOGNAME': 'cltbld', 21:07:12 INFO - 'MAIL': '/var/mail/cltbld', 21:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:12 INFO - 'MOZ_NO_REMOTE': '1', 21:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:07:12 INFO - 'NO_EM_RESTART': '1', 21:07:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:12 INFO - 'PWD': '/builds/slave/test', 21:07:12 INFO - 'SHELL': '/bin/bash', 21:07:12 INFO - 'SHLVL': '1', 21:07:12 INFO - 'TERM': 'linux', 21:07:12 INFO - 'TMOUT': '86400', 21:07:12 INFO - 'USER': 'cltbld', 21:07:12 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797', 21:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:12 INFO - '_': '/tools/buildbot/bin/python'} 21:07:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:12 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:07:12 INFO - Cleaning up... 21:07:12 INFO - Return code: 0 21:07:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:07:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:07:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xb031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe765c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe737a0>, '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 0xe746a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe74b30>, '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': '3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797', '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 21:07:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--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 21:07:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 21:07:12 INFO - Using env: {'DISPLAY': ':0', 21:07:12 INFO - 'HOME': '/home/cltbld', 21:07:12 INFO - 'LANG': 'en_US.UTF-8', 21:07:12 INFO - 'LANGUAGE': 'en_US:en', 21:07:12 INFO - 'LOGNAME': 'cltbld', 21:07:12 INFO - 'MAIL': '/var/mail/cltbld', 21:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:12 INFO - 'MOZ_NO_REMOTE': '1', 21:07:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:07:12 INFO - 'NO_EM_RESTART': '1', 21:07:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:12 INFO - 'PWD': '/builds/slave/test', 21:07:12 INFO - 'SHELL': '/bin/bash', 21:07:12 INFO - 'SHLVL': '1', 21:07:12 INFO - 'TERM': 'linux', 21:07:12 INFO - 'TMOUT': '86400', 21:07:12 INFO - 'USER': 'cltbld', 21:07:12 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797', 21:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:12 INFO - '_': '/tools/buildbot/bin/python'} 21:07:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:13 INFO - Downloading/unpacking blobuploader==1.2.4 21:07: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 21:07: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 21:07: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 21:07: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 21:07:14 INFO - Downloading blobuploader-1.2.4.tar.gz 21:07:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:07:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:07: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 21:07: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 21:07: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 21:07: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 21:07:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:07:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:07: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 21:07: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 21:07: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 21:07: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 21:07:14 INFO - Downloading docopt-0.6.1.tar.gz 21:07:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:07:14 INFO - Installing collected packages: blobuploader, requests, docopt 21:07:14 INFO - Running setup.py install for blobuploader 21:07:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:07:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:07:14 INFO - Running setup.py install for requests 21:07:15 INFO - Running setup.py install for docopt 21:07:15 INFO - Successfully installed blobuploader requests docopt 21:07:15 INFO - Cleaning up... 21:07:15 INFO - Return code: 0 21:07:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:07:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:07:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:15 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/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 0xb031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe765c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe737a0>, '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 0xe746a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe74b30>, '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': '3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797', '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 21:07:15 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:07:15 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:07:15 INFO - Using env: {'DISPLAY': ':0', 21:07:15 INFO - 'HOME': '/home/cltbld', 21:07:15 INFO - 'LANG': 'en_US.UTF-8', 21:07:15 INFO - 'LANGUAGE': 'en_US:en', 21:07:15 INFO - 'LOGNAME': 'cltbld', 21:07:15 INFO - 'MAIL': '/var/mail/cltbld', 21:07:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:15 INFO - 'MOZ_NO_REMOTE': '1', 21:07:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:07:15 INFO - 'NO_EM_RESTART': '1', 21:07:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:07:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:15 INFO - 'PWD': '/builds/slave/test', 21:07:15 INFO - 'SHELL': '/bin/bash', 21:07:15 INFO - 'SHLVL': '1', 21:07:15 INFO - 'TERM': 'linux', 21:07:15 INFO - 'TMOUT': '86400', 21:07:15 INFO - 'USER': 'cltbld', 21:07:15 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797', 21:07:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:15 INFO - '_': '/tools/buildbot/bin/python'} 21:07:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:07:15 INFO - Running setup.py (path:/tmp/pip-GLNE7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:07:15 INFO - Running setup.py (path:/tmp/pip-6SS3ZT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:07:15 INFO - Running setup.py (path:/tmp/pip-GqIaMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:07:15 INFO - Running setup.py (path:/tmp/pip-2R2aCZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:07:15 INFO - Running setup.py (path:/tmp/pip-fEAXdz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:07:15 INFO - Running setup.py (path:/tmp/pip-WxGtjM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:07:15 INFO - Running setup.py (path:/tmp/pip-tO1erV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:07:16 INFO - Running setup.py (path:/tmp/pip-C9Ju8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:07:16 INFO - Running setup.py (path:/tmp/pip-i9VQlb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:07:16 INFO - Running setup.py (path:/tmp/pip-st2y2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:07:16 INFO - Running setup.py (path:/tmp/pip-h3dUMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:07:16 INFO - Running setup.py (path:/tmp/pip-Kw6C7P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:07:16 INFO - Running setup.py (path:/tmp/pip-hXcRZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:07:16 INFO - Running setup.py (path:/tmp/pip-AWjDds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:07:16 INFO - Running setup.py (path:/tmp/pip-lww7kI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:07:16 INFO - Running setup.py (path:/tmp/pip-7ig_aY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:07:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:07:16 INFO - Running setup.py (path:/tmp/pip-GSk5FH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:07:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:07:16 INFO - Running setup.py install for manifestparser 21:07:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:07:16 INFO - Running setup.py install for mozcrash 21:07:16 INFO - Running setup.py install for mozdebug 21:07:17 INFO - Running setup.py install for mozdevice 21:07:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:07:17 INFO - Running setup.py install for mozfile 21:07:17 INFO - Running setup.py install for mozhttpd 21:07:17 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:07:17 INFO - Running setup.py install for mozinfo 21:07:17 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:07:17 INFO - Running setup.py install for mozInstall 21:07:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:07:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:07:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:07:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:07:17 INFO - Running setup.py install for mozleak 21:07:17 INFO - Running setup.py install for mozlog 21:07:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:07:17 INFO - Running setup.py install for moznetwork 21:07:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:07:17 INFO - Running setup.py install for mozprocess 21:07:17 INFO - Running setup.py install for mozprofile 21:07:18 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:07:18 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:07:18 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:07:18 INFO - Running setup.py install for mozrunner 21:07:18 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:07:18 INFO - Running setup.py install for mozscreenshot 21:07:18 INFO - Running setup.py install for moztest 21:07:18 INFO - Running setup.py install for mozversion 21:07:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:07:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:07:18 INFO - Cleaning up... 21:07:18 INFO - Return code: 0 21:07:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:07:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:07:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:18 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/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 0xb031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe765c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe737a0>, '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 0xe746a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe74b30>, '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': '3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797', '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 21:07:18 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 21:07:18 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:07:18 INFO - Using env: {'DISPLAY': ':0', 21:07:18 INFO - 'HOME': '/home/cltbld', 21:07:18 INFO - 'LANG': 'en_US.UTF-8', 21:07:18 INFO - 'LANGUAGE': 'en_US:en', 21:07:18 INFO - 'LOGNAME': 'cltbld', 21:07:18 INFO - 'MAIL': '/var/mail/cltbld', 21:07:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:18 INFO - 'MOZ_NO_REMOTE': '1', 21:07:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:07:18 INFO - 'NO_EM_RESTART': '1', 21:07:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:07:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:18 INFO - 'PWD': '/builds/slave/test', 21:07:18 INFO - 'SHELL': '/bin/bash', 21:07:18 INFO - 'SHLVL': '1', 21:07:18 INFO - 'TERM': 'linux', 21:07:18 INFO - 'TMOUT': '86400', 21:07:18 INFO - 'USER': 'cltbld', 21:07:18 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797', 21:07:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:18 INFO - '_': '/tools/buildbot/bin/python'} 21:07:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:07:18 INFO - Running setup.py (path:/tmp/pip-FkpQfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:07:18 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)) 21:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:07:18 INFO - Running setup.py (path:/tmp/pip-dKde6U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:07:18 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)) 21:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:07:18 INFO - Running setup.py (path:/tmp/pip-c7sZnD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:07:18 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)) 21:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:07:18 INFO - Running setup.py (path:/tmp/pip-vMFB88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:07:19 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)) 21:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:07:19 INFO - Running setup.py (path:/tmp/pip-OdW64H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:07:19 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)) 21:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:07:19 INFO - Running setup.py (path:/tmp/pip-zYGvnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:07:19 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)) 21:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:07:19 INFO - Running setup.py (path:/tmp/pip-x0h3eX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:07:19 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)) 21:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:07:19 INFO - Running setup.py (path:/tmp/pip-SVt9xW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:07:19 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)) 21:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:07:19 INFO - Running setup.py (path:/tmp/pip-nwdgy2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:07:19 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)) 21:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:07:19 INFO - Running setup.py (path:/tmp/pip-AfVV5D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:07:19 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)) 21:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:07:19 INFO - Running setup.py (path:/tmp/pip-Kkpgxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:07:19 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)) 21:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:07:19 INFO - Running setup.py (path:/tmp/pip-TkjQtM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:07:19 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)) 21:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:07:19 INFO - Running setup.py (path:/tmp/pip-A0RFsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:07:19 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)) 21:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:07:19 INFO - Running setup.py (path:/tmp/pip-3sms2s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:07:19 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)) 21:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:07:19 INFO - Running setup.py (path:/tmp/pip-XI3XgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:07:19 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)) 21:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:07:19 INFO - Running setup.py (path:/tmp/pip-iMGZS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:07:19 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)) 21:07:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:07:19 INFO - Running setup.py (path:/tmp/pip-9ERE9N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:07:19 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)) 21:07:19 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)) 21:07:19 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)) 21:07:19 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)) 21:07:19 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)) 21:07:19 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)) 21:07:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:07:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:07:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:07:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:07:21 INFO - Downloading blessings-1.6.tar.gz 21:07:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:07:21 INFO - Installing collected packages: blessings 21:07:21 INFO - Running setup.py install for blessings 21:07:21 INFO - Successfully installed blessings 21:07:21 INFO - Cleaning up... 21:07:21 INFO - Return code: 0 21:07:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:07:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:07:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:07:21 INFO - Reading from file tmpfile_stdout 21:07:21 INFO - Current package versions: 21:07:21 INFO - argparse == 1.2.1 21:07:21 INFO - blessings == 1.6 21:07:21 INFO - blobuploader == 1.2.4 21:07:21 INFO - docopt == 0.6.1 21:07:21 INFO - functools32 == 3.2.3-2 21:07:21 INFO - jsonschema == 2.5.1 21:07:21 INFO - manifestparser == 1.1 21:07:21 INFO - mozInstall == 1.12 21:07:21 INFO - mozcrash == 1.0 21:07:21 INFO - mozdebug == 0.1 21:07:21 INFO - mozdevice == 0.50 21:07:21 INFO - mozfile == 1.2 21:07:21 INFO - mozhttpd == 0.7 21:07:21 INFO - mozinfo == 0.9 21:07:21 INFO - mozleak == 0.1 21:07:21 INFO - mozlog == 3.4 21:07:21 INFO - moznetwork == 0.27 21:07:21 INFO - mozprocess == 0.25 21:07:21 INFO - mozprofile == 0.28 21:07:21 INFO - mozrunner == 6.13 21:07:21 INFO - mozscreenshot == 0.1 21:07:21 INFO - mozsystemmonitor == 0.3 21:07:21 INFO - moztest == 0.8 21:07:21 INFO - mozversion == 1.4 21:07:21 INFO - psutil == 3.1.1 21:07:21 INFO - requests == 1.2.3 21:07:21 INFO - wsgiref == 0.1.2 21:07:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:21 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/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 0xb031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe765c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe737a0>, '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 0xe746a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe74b30>, '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': '3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797', '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 21:07:21 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/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 21:07:21 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/pub --find-links http://pypi.pub.build.mozilla.org/pub 21:07:21 INFO - Using env: {'DISPLAY': ':0', 21:07:21 INFO - 'HOME': '/home/cltbld', 21:07:21 INFO - 'LANG': 'en_US.UTF-8', 21:07:21 INFO - 'LANGUAGE': 'en_US:en', 21:07:21 INFO - 'LOGNAME': 'cltbld', 21:07:21 INFO - 'MAIL': '/var/mail/cltbld', 21:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:21 INFO - 'MOZ_NO_REMOTE': '1', 21:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:07:21 INFO - 'NO_EM_RESTART': '1', 21:07:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:21 INFO - 'PWD': '/builds/slave/test', 21:07:21 INFO - 'SHELL': '/bin/bash', 21:07:21 INFO - 'SHLVL': '1', 21:07:21 INFO - 'TERM': 'linux', 21:07:21 INFO - 'TMOUT': '86400', 21:07:21 INFO - 'USER': 'cltbld', 21:07:21 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797', 21:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:21 INFO - '_': '/tools/buildbot/bin/python'} 21:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:21 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)) 21:07:21 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)) 21:07:21 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)) 21:07:21 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)) 21:07:21 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)) 21:07:21 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)) 21:07:21 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)) 21:07:21 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)) 21:07:21 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)) 21:07:21 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)) 21:07:21 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)) 21:07:21 INFO - Cleaning up... 21:07:21 INFO - Return code: 0 21:07:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:07:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0xb031f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcd0a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe765c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe737a0>, '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 0xe746a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe74b30>, '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': '3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797', '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 21:07:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:07:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:07:21 INFO - Using env: {'DISPLAY': ':0', 21:07:21 INFO - 'HOME': '/home/cltbld', 21:07:21 INFO - 'LANG': 'en_US.UTF-8', 21:07:21 INFO - 'LANGUAGE': 'en_US:en', 21:07:21 INFO - 'LOGNAME': 'cltbld', 21:07:21 INFO - 'MAIL': '/var/mail/cltbld', 21:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:21 INFO - 'MOZ_NO_REMOTE': '1', 21:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:07:21 INFO - 'NO_EM_RESTART': '1', 21:07:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:21 INFO - 'PWD': '/builds/slave/test', 21:07:21 INFO - 'SHELL': '/bin/bash', 21:07:21 INFO - 'SHLVL': '1', 21:07:21 INFO - 'TERM': 'linux', 21:07:21 INFO - 'TMOUT': '86400', 21:07:21 INFO - 'USER': 'cltbld', 21:07:21 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797', 21:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:21 INFO - '_': '/tools/buildbot/bin/python'} 21:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:07:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:07:21 INFO - Cleaning up... 21:07:21 INFO - Return code: 0 21:07:21 INFO - Running post-action listener: _resource_record_post_action 21:07:21 INFO - Running post-action listener: _start_resource_monitoring 21:07:22 INFO - Starting resource monitoring. 21:07:22 INFO - [mozharness: 2017-05-19 04:07:22.029647Z] Finished create-virtualenv step (success) 21:07:22 INFO - [mozharness: 2017-05-19 04:07:22.030578Z] Running install step. 21:07:22 INFO - Running pre-action listener: _resource_record_pre_action 21:07:22 INFO - Running main action method: install 21:07:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:07:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:07:22 INFO - Reading from file tmpfile_stdout 21:07:22 INFO - Detecting whether we're running mozinstall >=1.0... 21:07:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:07:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:07:22 INFO - Reading from file tmpfile_stdout 21:07:22 INFO - Output received: 21:07:22 INFO - Usage: mozinstall [options] installer 21:07:22 INFO - Options: 21:07:22 INFO - -h, --help show this help message and exit 21:07:22 INFO - -d DEST, --destination=DEST 21:07:22 INFO - Directory to install application into. [default: 21:07:22 INFO - "/builds/slave/test"] 21:07:22 INFO - --app=APP Application being installed. [default: firefox] 21:07:22 INFO - mkdir: /builds/slave/test/build/application 21:07:22 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'] 21:07:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 21:07:39 INFO - Reading from file tmpfile_stdout 21:07:39 INFO - Output received: 21:07:39 INFO - /builds/slave/test/build/application/firefox/firefox 21:07:39 INFO - Running post-action listener: _resource_record_post_action 21:07:39 INFO - [mozharness: 2017-05-19 04:07:39.746508Z] Finished install step (success) 21:07:39 INFO - [mozharness: 2017-05-19 04:07:39.746784Z] Running run-tests step. 21:07:39 INFO - Running pre-action listener: _resource_record_pre_action 21:07:39 INFO - Running main action method: run_tests 21:07:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:07:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:07:39 INFO - Python 2.7.3 21:07:39 INFO - Return code: 0 21:07:39 INFO - grabbing minidump binary from tooltool 21:07:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.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')]} 21:07:39 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 0xe737a0>, '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 0xe746a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe74b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:07:39 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 21:07:39 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 21:07:39 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 21:07:39 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:07:39 INFO - Return code: 0 21:07:39 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:07:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:07:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:07:39 INFO - ENV: RUST_BACKTRACE is now 1 21:07:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:07:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:07:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:07:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-083 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:07:39 INFO - Using env: {'DISPLAY': ':0', 21:07:39 INFO - 'HOME': '/home/cltbld', 21:07:39 INFO - 'LANG': 'en_US.UTF-8', 21:07:39 INFO - 'LANGUAGE': 'en_US:en', 21:07:39 INFO - 'LOGNAME': 'cltbld', 21:07:39 INFO - 'MAIL': '/var/mail/cltbld', 21:07:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:07:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:07:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:07:39 INFO - 'MOZ_NO_REMOTE': '1', 21:07:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:07:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:07:39 INFO - 'NO_EM_RESTART': '1', 21:07:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:07:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:07:39 INFO - 'PWD': '/builds/slave/test', 21:07:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:07:39 INFO - 'RUST_BACKTRACE': '1', 21:07:39 INFO - 'SHELL': '/bin/bash', 21:07:39 INFO - 'SHLVL': '1', 21:07:39 INFO - 'TERM': 'linux', 21:07:39 INFO - 'TMOUT': '86400', 21:07:39 INFO - 'USER': 'cltbld', 21:07:39 INFO - 'XDG_SESSION_COOKIE': '3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797', 21:07:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:07:39 INFO - '_': '/tools/buildbot/bin/python'} 21:07:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-083', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:07:40 INFO - mozversion application_buildid: 20170519032746 21:07:40 INFO - mozversion application_changeset: 8e98dab5054dd093a37ba20c62cf0523e484cfbd 21:07:40 INFO - mozversion application_display_name: Nightly 21:07:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:07:40 INFO - mozversion application_name: Firefox 21:07:40 INFO - mozversion application_remotingname: firefox 21:07:40 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:07:40 INFO - mozversion application_vendor: Mozilla 21:07:40 INFO - mozversion application_version: 55.0a1 21:07:40 INFO - mozversion platform_buildid: 20170519032746 21:07:40 INFO - mozversion platform_changeset: 8e98dab5054dd093a37ba20c62cf0523e484cfbd 21:07:40 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:07:40 INFO - mozversion platform_version: 55.0a1 21:07:40 INFO - using testdate: 1495166860 21:07:40 INFO - actual date: 1495166860 21:07:40 INFO - starting webserver on 'localhost:34338' 21:07:40 INFO - SUITE-START | Running 2 tests 21:07:40 INFO - TEST-START | dromaeo_css 21:07:40 INFO - operating with platform_type : linux_ 21:07:40 INFO - Initialising browser for dromaeo_css test... 21:07:40 INFO - TEST-INFO | started process 3306 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQHPMBA/profile http://localhost:34338/getInfo.html) 21:07:40 INFO - PID 3306 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2941: String.localeCompare is deprecated; use String.prototype.localeCompare instead 21:07:45 INFO - PID 3306 | __metrics Screen width/height:1600/1200 21:07:45 INFO - PID 3306 | colorDepth:24 21:07:45 INFO - PID 3306 | Browser inner width/height: 1024/695 21:07:45 INFO - PID 3306 | __metrics 21:07:47 INFO - TEST-INFO | 3306: exit 0 21:07:47 INFO - Browser initialized. 21:07:47 INFO - Running cycle 1/1 for dromaeo_css test... 21:07:47 INFO - TEST-INFO | started process 3486 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQHPMBA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:07:59 INFO - PID 3486 | RSS: Main: 166834176 21:07:59 INFO - PID 3486 | 21:11:04 INFO - PID 3486 | Cycle 1(1): loaded http://localhost:34338/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34338/tests/dromaeo/cssquery-ext.html) 21:11:06 INFO - PID 3486 | RSS: Main: 174092288 21:11:06 INFO - PID 3486 | 21:14:08 INFO - PID 3486 | Cycle 1(1): loaded http://localhost:34338/tests/dromaeo/cssquery-ext.html (next: http://localhost:34338/tests/dromaeo/cssquery-jquery.html) 21:14:09 INFO - PID 3486 | RSS: Main: 173887488 21:14:09 INFO - PID 3486 | 21:17:11 INFO - PID 3486 | Cycle 1(1): loaded http://localhost:34338/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34338/tests/dromaeo/cssquery-mootools.html) 21:17:11 INFO - PID 3486 | RSS: Main: 175669248 21:17:11 INFO - PID 3486 | 21:20:13 INFO - PID 3486 | Cycle 1(1): loaded http://localhost:34338/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34338/tests/dromaeo/cssquery-prototype.html) 21:20:14 INFO - PID 3486 | RSS: Main: 175210496 21:20:14 INFO - PID 3486 | 21:23:17 INFO - PID 3486 | Cycle 1(1): loaded http://localhost:34338/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34338/tests/dromaeo/cssquery-yui.html) 21:23:17 INFO - PID 3486 | RSS: Main: 173031424 21:23:17 INFO - PID 3486 | 21:26:19 INFO - PID 3486 | Cycle 1(1): loaded http://localhost:34338/tests/dromaeo/cssquery-yui.html (next: http://localhost:34338/tests/dromaeo/cssquery-dojo.html) 21:26:20 INFO - PID 3486 | RSS: Main: 179806208 21:26:20 INFO - PID 3486 | 21:26:20 INFO - PID 3486 | __start_tp_report 21:26:20 INFO - PID 3486 | _x_x_mozilla_page_load 21:26:20 INFO - PID 3486 | _x_x_mozilla_page_load_details 21:26:20 INFO - PID 3486 | |i|pagename|runs| 21:26:20 INFO - PID 3486 | |0;dojo.html;2705.715899830518;2725.9591106133425;2727.645406097207;2748.106865268787;2764.115483045424;5273.630845840793;5318.122509785885;5324.068288049591;5325.973370133153;5370.3287089113865;5332.200169974506;5342.038433082043;5412.404635490093;5423.2136340230745;5430.8913821723545;4473.172463094322;4664.97667511662;4697.17799385108;4711.858644240661;4770.189067858455;4711.458182309027;4751.144793937107;4769.427668679763;4770.6422018348585;4791.904161916759;4648.837290694843;4671.27595222741;4671.696339737906;4691.929621055687;4764.2615394613895;4711.811527538895;4745.383100196987;4768.49930757269;4781.6891902026255;4802.255650374198;4685.906281874343;4688.226442636961;4715.7877895494785;4717.952820471785;4757.6907501012665;5208.114620514521;5324.92012619811;5327.334083239595;5330.28041214435;5351.063563876306;5664.20701101846;5696.287964004499;5733.942660573424;5767.538596912237;5771.595988280822;5776;5778.508826749689;5788.82633520995;5789.710514474259;5795.3045634523705;5320.893582128336;5348.411674715817;5348.414260445001;5356.384015838151;5367.490088441592;5820.185174075633;5900.734466948998;5903.498202652822;5909.6158749681135;5909.940900590939;5603.719814009283;5612;5624.3813180550105;5710.400407957188;5720;5783.1325301204315;5786.218860453869;5797;5803.245578074908;5819.098039803837;5627.831165065055;5731.541476681856;5748.109043098327;5754.251947246831;5757.078867381283;5622.353429355677;5739.253896993364;5749.425057494301;5752.9712351437975;5755.165501002415;4720.905581888343;4736.360591320127;4798;4807.399075115611;4809.254565542346;4107.979460102681;4109.9589004109575;4112;4116.670666346685;4154.169166166718;4763.571278584944;4843.806247750121;4849.078675051729;4863.7324947128245;4875.756212189376;5579.860503487445;5632.52123569493;5646.745896434671;5649.54803615718;5673.602847800615;4799.880002999883;4816.686915350491;4837.830675926326;4858.17411040124;4880.731559764247;5064.037832811754;5079.644424890296;5083.898322033612;5084.466131056186;5099.694018358836;5177.637565370388;5246.580273578181;5248.60635452335;5250.212468129811;5354.223637572608;5605.1872478491205;5668.744906479136;5679.403662615366;5686.976344257908;5688.914666280092;5365.275687782099;5366.034113859543;5368;5384.192371144203;5384.703841288767;5603.607747457639;5636.802711905064;5666.320041595035;5679.971600141973;5681.573881958952;5673.517750991047;5796.82609521715;5805.76776928935;5815.534757219328;5823;5501.202325662836;5538.252335934597;5594.356648985418;5646.3506696728755;5667.40492248308;5602.971985140048;5612.186232996111;5613.803516876889;5617.550595952396;5641.097424412238;5380.192971054373;5470.234167216672;5532.889342213214;5536.169574563686;5543.9168412474655;5456.863578410572;5557.972210138923;5561.4716601922755;5629.915551266652;5690.573207009408;5471;5473.452654734495;5475.4250803665045;5484.890302194013;5541.778328866801 21:26:20 INFO - PID 3486 | |1;ext.html;685.8148299959012;744.3301029073833;762.5158024654345;1067.9519421626026;1083.5070043130368;32239.51640725391;33640;33669.158271043234;33669.158271043234;33737.83131084341;35719.82140089296;36105.27789444216;36127.4580881287;36160.276794464095;36234.63765362352;6926.584404935695;6954.8261293467685;7103.289671032881;7142.535735177223;7161.928380716205;7024.789256322319;7169.318914703095;7180.17427995782;7194.352508274254;7198.172210195816;7097.325754053357;7197.460190485708;7225.313595208447;7225.927740722578;7240.565566066027;7188.8202794930285;7192.568445893211;7221.675024623904;7227.674754636054;7234.927650723478;7084.362407383309;7114.039604653357;7120.038794762692;7123.715051397938;7136.393406560397;32185;32215.677843221503;32231;32271.67728322734;32304.19239519007;3054.69453054695;3085.475469170224;3100.193949573105;3123.04747052149;3125.7030582094662;24574.63138052913;24575.63136552953;24606.384840379134;24638;24725.629115563283;3121.797083189608;3131.264152924061;3145.2294187923876;3149.2599239178776;3179.72972297355;139793;140313;148525.2573737135;151518;153177;39928.800355998035;39966;40005.39991900066;40063;40178.19643607111;40769.18461630751;40935.38596921049;41022;41196.38205426921;41311;11975.940120299343;12060.819087713691;12063.939680301542;12075.939620301842;12080.033597312195;9587.568559414703;9609.375390599589;9613.134817866287;9625.807483850283;9632;12712.809307860205;12815.29515876617;12823.61529154127;12851.100422970303;12854.357282135856;5474.151506516497;5532;5539.7784088636;5587.078132108157;5627.746751396197;874.1477059866579;880.4101252161067;902.9909700903038;913.4291068082448;931.725141083382;20259.791967351637;21041.15835366599;21353.78646213549;21504.247351342627;21529.56940861174;972.3825370889394;973.9805203896024;976.6288810252058;998.7752755630071;1005.8591797148405;11177.329360238411;11179;11333.773324533464;11425.200235983568;11459.828102578467;161000;162446;163672;163841;165126;40945.1810963785;41146.58853411428;41207.58792412098;41287;41343.58656413457;1217.3852204636603;1234.7653945750458;1236.2644226685109;1241.075398827861;1253.2417887178308;19731.506712332306;19735;20223.19107235694;21047.368578942656;21199.470013249793;29849.850750746107;29859.70140298569;29872.25319366946;29874;29911.70088299176;138702;138778.30610846882;138869.3056534711;139066.74199661243;139301;28882.855585721936;29181.7081829179;29258.414831703674;30975.690243098183;30991;36503.634963651086;37203.06992325214;37224.06939826526;37472.62527374691;37476.43785343168;26190;27239.72760272372;27370.589441158798;27675.86162069177;28165.43669126647;27457.31356716098;28130;28241.01156459514;29138.27154321159;29170.27074323074;30777.846110769304;30875.536866947463;30904;30994;31050.223744406572;26766.866165669046;26824.463510730067;27783.722162778115;28021.719782801913;28774.42451151007;20386.59226815485;22639.094436223026;22817.885910571003;22976.4255893604;23137 21:26:20 INFO - PID 3486 | |2;jquery.html;413.9441175441318;418.13380281690127;431.8682801745467;440.50663257151984;442.55081092690926;17023.744643830352;17082.14589270536;17258.223379947918;17809.376671816488;17876.284948602057;17104.230309636067;17194.82805171948;18600.627987440243;18985.14566844492;19185.232590696356;5303.549198318147;5500.697461639608;5518.420565840599;5559.11054231323;5676.2620859288445;5491;5497.505224529791;5506.091494903336;5522.696251706155;5524.751386187611;5357.517823395893;5401.864953376177;5433.646812957145;5446.645968012067;5460.399356070829;5433.266509021271;5464.316960379932;5479.1781232815;5486.067368547337;5493.395726470125;4872.171730805771;4954.529319714621;4986.750662466899;4992.975035124801;5005.6496045276845;22320.665190022162;22442.77557224423;22532.774672253232;22600.095996160133;22700.65949010766;1612.46788559775;1685.4522280258966;1694.4747128390238;1695.5252529291818;1696.2621259752048;14448.927755361261;14899.553013409615;15136;15245.771313430307;15292.158931258777;1981.395674319332;2028.8985550722552;2065.0913598016823;2070.285751415774;2084.6351888419467;77886;84432.99999999939;86853.56573217157;91112.99999999933;92351.53824230836;11065.446727663746;11262.959001069828;17369.56576085608;17747;17939.192736326637;32916.50625240623;32983.50524742131;32989.3402131956;33018.834905825315;33077.503837442455;8412.411131220755;8773.034966153718;8880.555972201364;9010.14403631654;9156.175944165057;6584.144061272004;6702.296258892746;6970;7118.750843720445;7135.423089254425;9404.95297523508;9490.488519247923;9506.85739713891;9522.95238523803;9642.841080022296;3801.467794508771;3996.2407142642805;4013.8823000674374;4030.214108248922;4035.394690796404;862.8490014247482;889.217488610019;893.6246776353947;898.5417437107122;920.4845286639503;16891.493255202364;16918.661626767396;17435.12824358777;17686.439667845203;17718.91140544289;885.6147575804546;892.8169725206317;899.4738078224182;900.8063266397756;908.9454632722058;9341.90658093424;9587.651025498797;9784.608615655436;9867.699000259323;9872.506374681238;321236;358339;360320;364291;368066;74535;77485.37719342143;77746;78015.60992195003;79923;1087.1954753482523;1118.7370967822555;1127.9492422840992;1129.5820546397722;1129.5989923577013;17432.128393580017;17736.91131544334;18441.354552590594;18465.9076704621;18724.157412916724;37333.22720896272;37680.81159594184;38823.417648735856;38995.41506877456;40580.1883962325;46842.53157468382;47447.05105897932;47808;47878.760606196745;47937.760311198224;8075.757727268191;8111.107778144281;8211.95894020526;8240;8309.421209970327;11616.419179041182;12167.39163041862;12927.482900683868;12947.741045179233;13150.60548183556;11419.486123124645;11461.255018423775;11731.706707332043;11772.941135294268;11955.64133076009;10862.837057443987;10907.127429805756;10926.50830712604;11014.559417623206;11340.09279257674;11265.817089205515;12032.879671203526;12145.210561313486;12145.757084858431;12311.138220324492;8068.233517815798;8259.669613215405;8265.95867020661;8423.8736418955;8546.09242800926;11124.555017799197;11144.832827507757;11217.270877392943;11319.320840749582;11337.433128343715 21:26:20 INFO - PID 3486 | |3;mootools.html;1209.9818502722458;1281.3273031658373;1287.6845172932633;1288.6262983734716;1296.533248030709;10070.345427547205;10546;10564.524596393152;10567.735806604838;10800;10636.840447393275;10786.73033174171;10821.242513024092;10824.458777061154;10843.349399036064;2169.078141789741;2214.756376798559;2218.245796429214;2221.7556068832414;2227.042371780134;2172.8261739060836;2215.29110684581;2216.7229096362953;2220.9777902221012;2222.14447437736;2089.550746589483;2135.444784356063;2149.7312835895514;2155.5473350596317;2165.9025343859485;2117.6082424751394;2128.8935553222277;2158.719366482355;2161.848670593059;2174.097749433983;1920.193518722126;2056.5784014277037;2178.313831143201;2209.4586826227514;2210.5910406574835;10235.744106397326;10271.897281027168;10272;10378.716682329876;10383.065524102867;5225.242339860737;5383.596230282745;5398.352197736297;5408.378036525811;5409.972950135263;3068.2789544457037;3217.9034628961167;3302.3560405720896;3308.3052558962645;3338.88313909012;1055.3562326980536;1079.5411949921252;1097.4732128578248;1158.7161145519317;1163.098598586094;15432.38270469191;15594.220288985618;15599.92200039004;15607.531774046796;15620.297086631015;4405.845795397146;4595.747233902168;4615.076984603025;4648.535146485325;4678.274867395559;10926.672199834018;10951.069159121405;10958.616448424267;10965.780684386267;10978.890211097947;5411.080116380225;5415.918761218585;5416.91874621881;5418.485243901901;5429.972850135724;4744.264638980963;4975.800967961313;5070.721110338966;5093.770780314895;5112.488751124932;3647.9635203648154;3800.1259710266795;3811.7522361046445;3860.092878173627;3904.4143378492886;1133.6259034518755;1136.4488223211736;1152.2428296847374;1152.8040233160382;1168.9064874809994;698.7798843364324;723.1322413104191;726.0561270348526;727.5016613619688;740.2486476226634;5391.137418013099;5463.562914966793;5502.064649009598;5592.350256674291;5638.210650508932;535.1197280473599;550.4852962480094;551.2613098448019;553.6594994078613;558.1126009644685;3331.1179183761096;4042.2521833460314;4280.4863416390235;4333;4406.7576283304725;12965.481380744664;13611.183329000292;13640.113392629448;13649.590512284647;13662.316884155753;13023;13394.062415631008;13406.262655554037;13579.52471663487;13585.796213056812;7096.858062838714;7227.710891564278;7259.237780033126;7277.927220727831;7285.817854553678;5915.556333275108;6141.232345956755;6218.689065546795;6230.50155987529;6414.967925160345;11509.366984815915;11606;11733.530658773554;12026.639200823989;12114.515419383479;11811.515602896994;12039.337836419081;12073.818892716792;12181.634550963485;12270.202436841577;8298.21166989135;8488.10874858131;8488.702895398632;8501.362397820065;8514.446560973516;9442.48066356357;9570.377925434825;9572.282078843975;9741.951290243504;9827.606895724091;8228.177182281963;8256.339492840678;8327.20891515305;8385.245327920517;8419.158084191531;7916.4062695299235;8054.194580541899;8118.066422361504;8128.9593552031865;8334.583270836556;6968.303169682991;7106.715731370894;7185.964070179615;7196.4962452627815;7211.134663840163;5120.923186152137;5125.8974820502635;5189.143791274398;5265.499777521282;5283.9432113578205;5286.20706893969;5345.893082138413;5359.410464848941;5410.080286351251;5525.475079867406 21:26:20 INFO - PID 3486 | |4;prototype.html;391.86284800319885;393.63195412289514;397.4296883971499;398.18769709792025;398.2433376584489;5482.643628164172;5494.697791621459;5503.229547863302;5535.197396377528;5537.501624853768;4890.584300334476;5365.731713414323;5401.460583733637;5401.756920938557;5409.134538473845;4255.787210639471;4263.467066616665;4270.231358355495;4281.336392859112;4282.207791558556;4276.700630955835;4280.507741609724;4298.118885628439;4303;4303.612674859262;4172.499300083994;4245.660347172235;4261.296886013804;4263.509696384909;4273.957260427387;4211.115665710205;4218.219629368546;4223.21870453967;4225.746455212697;4234.30134027885;3848.4804551385487;3853.499045124116;3856.382978723391;3873.225354928997;3884.8251828667776;5220.791168353261;5278.234655974862;5284.07528682479;5298.629095963284;5331;5053.418856831438;5057.924131138036;5075.162598171334;5094.414142373637;5109.540141387293;5758.309002919635;5768.3654797972185;5771.365149833515;5773.480386765169;5779.595428320019;4238.470191226097;4343.9140214946265;4368.213721530124;4389.100234451929;4392.165488557164;5837.29952405714;5953.374895635982;5962.314333851619;5966.3138739045135;5984.910226346608;3967.175099454226;3973.6225058619384;3976.204759048202;3978.5026871641044;4010.6991975601945;4044.7775372354213;4049.0889549851636;4054.8986275342763;4064.7967601620394;4075.612816782401;4610.723356598614;4727.101850648434;4735.621150307967;4740.3837501124635;4743.739094349844;5723.77104915807;5729.627574207663;5736.827895163152;5739.540836733051;5756.280464941882;1416.178616402484;1437.5974727076436;1438.4605772835187;1439.632893612143;1441.978370324446;890.8307421589877;934.8270569944445;949.050949050949;950.496236994394;959.8625628630095;4934.111859865258;4937.506249375034;4943.110240156806;4944.456109827988;4961.479044700327;5899.941000590025;5930.8813823723285;5932.940670593325;5938.376470470625;5957.255343082114;4791.784369703371;4846.636502262344;4905.901881962341;4918.213085906309;4941.431735350408;3094.4275309067443;3122.98438507806;3128.593282873212;3128.9530657040164;3132.3578666373337;5416.241726158341;5447.5641948644015;5479.890402191933;5497.5601951843755;5504.422035686275;5855.268091488564;6065.696715164224;6114.877702445926;6115.4099934016585;6124.479419249325;5476.863078423071;5488.69812160335;5492.80775172875;5509.807156749494;5522.116461366242;5818.592698511064;5907.32065812437;5925.762969481172;5929.258842644669;5998.9100163496705;5846.473817356458;5847.1229315603;5864.413558644102;5869.119632055055;5901.468867801918;5272.182811664198;5460.2355670207;5486.972565137149;5505.229267902417;5515;4029.133736246721;4073.6741060715663;4083.040485485849;4088.0801819590356;4094.0992981544014;5869.559783016376;5958.867815115114;5963.7912673056235;5967.313758917607;5987.970060149672;5757.107648314518;5757.884842303214;5790.044642634087;5793.710314484343;5803;5745.626534275259;5753.424657534213;5767.221425107557;5790.681512516852;5811.215485909348;5443.8094666686475;5610.298712660918;5668.886622267449;5680.744366503434;5681.829545113653;5767.307923049261;5777.873314703593;5783.652980821164;5802.158686990447;5804.053243794092;5432.674039557639;5583.664980101207;5607.3551541571605;5614.24207731951;5621.54709931366 21:26:20 INFO - PID 3486 | |5;yui.html;659.3307792590522;666.9666516674165;667.5560752099852;744.1182199094077;746.6042997211476;13167.6708082298;13577.185368877861;13595.52415665452;16230.269637866295;16918.49244522663;16106.677866442693;16121;16165.919170404131;16171;16352.509424717247;900.5092224737501;905.5879574793453;907.2923119966437;907.3285768531273;910.4127837544779;903.2006674093409;904.7557159566913;909.1272378516632;909.236241557092;909.2634965677789;939.1453777062874;944.8724422202984;946.3375637054055;948.0803620488116;948.6395169835453;943.5046600534705;948.1419315519466;950.2160717408132;951.7953639967371;953.1850268020812;634.5177664974607;674.790814847394;680.6222546486698;686.2005763285766;701.9403350715195;14149.434022639081;14306.499272525412;14328.426862925471;14476.493322733653;14486;14981.925090374587;15970;15993.520194394187;16092.75860862088;16132.919335403365;12105.213161144497;12375.071869609725;12471.812922806164;12472.50109995599;12489.313087780169;2685.610586464971;2716.877740501682;2717.279920820984;2719.3745438549245;2727.8226915250443;69478.65260673715;69487.65256173686;69574;69895.65052174758;71187;11092.944535277273;11950.282983021047;12004.279743215435;12198.939005304917;12270.2637841728;17656.382026629264;21922.561548768936;22409;22448.43878903008;22581.322560323217;6073.1497590337385;6219.626822390671;6229.034499652561;6230.127782110508;6270.31026587075;2870.2680816391685;2914.184028472031;2920.269932516871;2920.8831646734316;2929.838858862783;3324.4680851063713;3329.816860072671;3397.3375191837354;3410.3520331137006;3411.283630437636;679.5209377388929;684.6405637040494;688.6900894597451;689.9827504312433;692.0415224913531;482.4500069920294;483.61794182595355;486.2536007228957;497.107691693404;501.9171836646912;9002.23481004122;9655.082767137252;9718.416894986323;9789.412635241908;9934.701958941243;553.8117040206349;556.2907293201201;556.7299859568107;558.6871352042868;564.51169738177;4216.578342165759;4389.780510974502;4448.177087238806;4518.073794872043;4565.794539245742;60559.39440605538;61125.08312375318;62183;62238.37761622326;64053.67973160104;53520;54450.18324725132;55360.44639553553;55362.16956745652;55465;51279.230811537855;52535.211971820456;52750.73624631929;53027.469725303796;56260.43739562552;9715.27135464857;10721.517531710935;11178.385188814367;11438.542458301576;11721.355325457182;24513.509729804948;24525.754742452347;25285.74714252834;25310.240692779247;25476;40001.199975999734;40436.59563404446;40830.59169408268;41762.58237417709;46237.07525849397;12833.743325133632;12855.614331570068;12910.548130815376;12962.22226666403;12970.675733106747;15721.764173537178;16084.597885052968;16091.954022988468;16227;16272.918635406748;13777.931110344383;14234.14595124296;14417.13497190172;14604.926975365055;14630.049046811922;13518.59444216675;13886.166829990232;13976.301184940916;14028.368723407268;14094.929525352307;13322.666933326356;14159.858401415853;14207.28963551839;14251.21618311003;14572.344244508811;9762.85355719679;10270.229732770222;10291.897081029394;10553.366797992145;11090.112790976542;10521.158307335549;10599.735006624587;10640.40393940915;11347.148963827582;11356.94321528387 21:26:20 INFO - PID 3486 | __end_tp_report 21:26:20 INFO - PID 3486 | __start_cc_report 21:26:20 INFO - PID 3486 | _x_x_mozilla_cycle_collect,269 21:26:20 INFO - PID 3486 | __end_cc_report 21:26:20 INFO - PID 3486 | __startTimestamp1495167980034__endTimestamp 21:26:20 INFO - PID 3486 | 21:26:20 INFO - PID 3486 | ------- Summary: start ------- 21:26:20 INFO - PID 3486 | Number of tests: 6 21:26:20 INFO - PID 3486 | 21:26:20 INFO - PID 3486 | [#0] dojo.html Cycles:165 Average:5235.77 Median:5384.70 stddev:624.87 (11.6%) stddev-sans-first:594.43 21:26:20 INFO - PID 3486 | Values: 2705.7 2726.0 2727.6 2748.1 2764.1 5273.6 5318.1 5324.1 5326.0 5370.3 5332.2 5342.0 5412.4 5423.2 5430.9 4473.2 4665.0 4697.2 4711.9 4770.2 4711.5 4751.1 4769.4 4770.6 4791.9 4648.8 4671.3 4671.7 4691.9 4764.3 4711.8 4745.4 4768.5 4781.7 4802.3 4685.9 4688.2 4715.8 4718.0 4757.7 5208.1 5324.9 5327.3 5330.3 5351.1 5664.2 5696.3 5733.9 5767.5 5771.6 5776.0 5778.5 5788.8 5789.7 5795.3 5320.9 5348.4 5348.4 5356.4 5367.5 5820.2 5900.7 5903.5 5909.6 5909.9 5603.7 5612.0 5624.4 5710.4 5720.0 5783.1 5786.2 5797.0 5803.2 5819.1 5627.8 5731.5 5748.1 5754.3 5757.1 5622.4 5739.3 5749.4 5753.0 5755.2 4720.9 4736.4 4798.0 4807.4 4809.3 4108.0 4110.0 4112.0 4116.7 4154.2 4763.6 4843.8 4849.1 4863.7 4875.8 5579.9 5632.5 5646.7 5649.5 5673.6 4799.9 4816.7 4837.8 4858.2 4880.7 5064.0 5079.6 5083.9 5084.5 5099.7 5177.6 5246.6 5248.6 5250.2 5354.2 5605.2 5668.7 5679.4 5687.0 5688.9 5365.3 5366.0 5368.0 5384.2 5384.7 5603.6 5636.8 5666.3 5680.0 5681.6 5673.5 5796.8 5805.8 5815.5 5823.0 5501.2 5538.3 5594.4 5646.4 5667.4 5603.0 5612.2 5613.8 5617.6 5641.1 5380.2 5470.2 5532.9 5536.2 5543.9 5456.9 5558.0 5561.5 5629.9 5690.6 5471.0 5473.5 5475.4 5484.9 5541.8 21:26:20 INFO - PID 3486 | 21:26:20 INFO - PID 3486 | [#1] ext.html Cycles:180 Average:29718.41 Median:17086.01 stddev:38617.33 (226.0%) stddev-sans-first:38664.12 21:26:20 INFO - PID 3486 | Values: 685.8 744.3 762.5 1068.0 1083.5 32239.5 33640.0 33669.2 33669.2 33737.8 35719.8 36105.3 36127.5 36160.3 36234.6 6926.6 6954.8 7103.3 7142.5 7161.9 7024.8 7169.3 7180.2 7194.4 7198.2 7097.3 7197.5 7225.3 7225.9 7240.6 7188.8 7192.6 7221.7 7227.7 7234.9 7084.4 7114.0 7120.0 7123.7 7136.4 32185.0 32215.7 32231.0 32271.7 32304.2 3054.7 3085.5 3100.2 3123.0 3125.7 24574.6 24575.6 24606.4 24638.0 24725.6 3121.8 3131.3 3145.2 3149.3 3179.7 139793.0 140313.0 148525.3 151518.0 153177.0 39928.8 39966.0 40005.4 40063.0 40178.2 40769.2 40935.4 41022.0 41196.4 41311.0 11975.9 12060.8 12063.9 12075.9 12080.0 9587.6 9609.4 9613.1 9625.8 9632.0 12712.8 12815.3 12823.6 12851.1 12854.4 5474.2 5532.0 5539.8 5587.1 5627.7 874.1 880.4 903.0 913.4 931.7 20259.8 21041.2 21353.8 21504.2 21529.6 972.4 974.0 976.6 998.8 1005.9 11177.3 11179.0 11333.8 11425.2 11459.8 161000.0 162446.0 163672.0 163841.0 165126.0 40945.2 41146.6 41207.6 41287.0 41343.6 1217.4 1234.8 1236.3 1241.1 1253.2 19731.5 19735.0 20223.2 21047.4 21199.5 29849.9 29859.7 29872.3 29874.0 29911.7 138702.0 138778.3 138869.3 139066.7 139301.0 28882.9 29181.7 29258.4 30975.7 30991.0 36503.6 37203.1 37224.1 37472.6 37476.4 26190.0 27239.7 27370.6 27675.9 28165.4 27457.3 28130.0 28241.0 29138.3 29170.3 30777.8 30875.5 30904.0 30994.0 31050.2 26766.9 26824.5 27783.7 28021.7 28774.4 20386.6 22639.1 22817.9 22976.4 23137.0 21:26:20 INFO - PID 3486 | 21:26:20 INFO - PID 3486 | [#2] jquery.html Cycles:180 Average:25258.65 Median:4005.06 stddev:59059.91 (1474.6%) stddev-sans-first:59196.13 21:26:20 INFO - PID 3486 | Values: 413.9 418.1 431.9 440.5 442.6 17023.7 17082.1 17258.2 17809.4 17876.3 17104.2 17194.8 18600.6 18985.1 19185.2 5303.5 5500.7 5518.4 5559.1 5676.3 5491.0 5497.5 5506.1 5522.7 5524.8 5357.5 5401.9 5433.6 5446.6 5460.4 5433.3 5464.3 5479.2 5486.1 5493.4 4872.2 4954.5 4986.8 4993.0 5005.6 22320.7 22442.8 22532.8 22600.1 22700.7 1612.5 1685.5 1694.5 1695.5 1696.3 14448.9 14899.6 15136.0 15245.8 15292.2 1981.4 2028.9 2065.1 2070.3 2084.6 77886.0 84433.0 86853.6 91113.0 92351.5 11065.4 11263.0 17369.6 17747.0 17939.2 32916.5 32983.5 32989.3 33018.8 33077.5 8412.4 8773.0 8880.6 9010.1 9156.2 6584.1 6702.3 6970.0 7118.8 7135.4 9405.0 9490.5 9506.9 9523.0 9642.8 3801.5 3996.2 4013.9 4030.2 4035.4 862.8 889.2 893.6 898.5 920.5 16891.5 16918.7 17435.1 17686.4 17718.9 885.6 892.8 899.5 900.8 908.9 9341.9 9587.7 9784.6 9867.7 9872.5 321236.0 358339.0 360320.0 364291.0 368066.0 74535.0 77485.4 77746.0 78015.6 79923.0 1087.2 1118.7 1127.9 1129.6 1129.6 17432.1 17736.9 18441.4 18465.9 18724.2 37333.2 37680.8 38823.4 38995.4 40580.2 46842.5 47447.1 47808.0 47878.8 47937.8 8075.8 8111.1 8212.0 8240.0 8309.4 11616.4 12167.4 12927.5 12947.7 13150.6 11419.5 11461.3 11731.7 11772.9 11955.6 10862.8 10907.1 10926.5 11014.6 11340.1 11265.8 12032.9 12145.2 12145.8 12311.1 8068.2 8259.7 8266.0 8423.9 8546.1 11124.6 11144.8 11217.3 11319.3 11337.4 21:26:20 INFO - PID 3486 | 21:26:20 INFO - PID 3486 | [#3] mootools.html Cycles:180 Average:6311.24 Median:3493.42 stddev:4129.60 (118.2%) stddev-sans-first:4123.40 21:26:20 INFO - PID 3486 | Values: 1210.0 1281.3 1287.7 1288.6 1296.5 10070.3 10546.0 10564.5 10567.7 10800.0 10636.8 10786.7 10821.2 10824.5 10843.3 2169.1 2214.8 2218.2 2221.8 2227.0 2172.8 2215.3 2216.7 2221.0 2222.1 2089.6 2135.4 2149.7 2155.5 2165.9 2117.6 2128.9 2158.7 2161.8 2174.1 1920.2 2056.6 2178.3 2209.5 2210.6 10235.7 10271.9 10272.0 10378.7 10383.1 5225.2 5383.6 5398.4 5408.4 5410.0 3068.3 3217.9 3302.4 3308.3 3338.9 1055.4 1079.5 1097.5 1158.7 1163.1 15432.4 15594.2 15599.9 15607.5 15620.3 4405.8 4595.7 4615.1 4648.5 4678.3 10926.7 10951.1 10958.6 10965.8 10978.9 5411.1 5415.9 5416.9 5418.5 5430.0 4744.3 4975.8 5070.7 5093.8 5112.5 3648.0 3800.1 3811.8 3860.1 3904.4 1133.6 1136.4 1152.2 1152.8 1168.9 698.8 723.1 726.1 727.5 740.2 5391.1 5463.6 5502.1 5592.4 5638.2 535.1 550.5 551.3 553.7 558.1 3331.1 4042.3 4280.5 4333.0 4406.8 12965.5 13611.2 13640.1 13649.6 13662.3 13023.0 13394.1 13406.3 13579.5 13585.8 7096.9 7227.7 7259.2 7277.9 7285.8 5915.6 6141.2 6218.7 6230.5 6415.0 11509.4 11606.0 11733.5 12026.6 12114.5 11811.5 12039.3 12073.8 12181.6 12270.2 8298.2 8488.1 8488.7 8501.4 8514.4 9442.5 9570.4 9572.3 9742.0 9827.6 8228.2 8256.3 8327.2 8385.2 8419.2 7916.4 8054.2 8118.1 8129.0 8334.6 6968.3 7106.7 7186.0 7196.5 7211.1 5120.9 5125.9 5189.1 5265.5 5283.9 5286.2 5345.9 5359.4 5410.1 5525.5 21:26:20 INFO - PID 3486 | 21:26:20 INFO - PID 3486 | [#4] prototype.html Cycles:180 Average:4751.48 Median:5412.69 stddev:1385.92 (25.6%) stddev-sans-first:1350.63 21:26:20 INFO - PID 3486 | Values: 391.9 393.6 397.4 398.2 398.2 5482.6 5494.7 5503.2 5535.2 5537.5 4890.6 5365.7 5401.5 5401.8 5409.1 4255.8 4263.5 4270.2 4281.3 4282.2 4276.7 4280.5 4298.1 4303.0 4303.6 4172.5 4245.7 4261.3 4263.5 4274.0 4211.1 4218.2 4223.2 4225.7 4234.3 3848.5 3853.5 3856.4 3873.2 3884.8 5220.8 5278.2 5284.1 5298.6 5331.0 5053.4 5057.9 5075.2 5094.4 5109.5 5758.3 5768.4 5771.4 5773.5 5779.6 4238.5 4343.9 4368.2 4389.1 4392.2 5837.3 5953.4 5962.3 5966.3 5984.9 3967.2 3973.6 3976.2 3978.5 4010.7 4044.8 4049.1 4054.9 4064.8 4075.6 4610.7 4727.1 4735.6 4740.4 4743.7 5723.8 5729.6 5736.8 5739.5 5756.3 1416.2 1437.6 1438.5 1439.6 1442.0 890.8 934.8 949.1 950.5 959.9 4934.1 4937.5 4943.1 4944.5 4961.5 5899.9 5930.9 5932.9 5938.4 5957.3 4791.8 4846.6 4905.9 4918.2 4941.4 3094.4 3123.0 3128.6 3129.0 3132.4 5416.2 5447.6 5479.9 5497.6 5504.4 5855.3 6065.7 6114.9 6115.4 6124.5 5476.9 5488.7 5492.8 5509.8 5522.1 5818.6 5907.3 5925.8 5929.3 5998.9 5846.5 5847.1 5864.4 5869.1 5901.5 5272.2 5460.2 5487.0 5505.2 5515.0 4029.1 4073.7 4083.0 4088.1 4094.1 5869.6 5958.9 5963.8 5967.3 5988.0 5757.1 5757.9 5790.0 5793.7 5803.0 5745.6 5753.4 5767.2 5790.7 5811.2 5443.8 5610.3 5668.9 5680.7 5681.8 5767.3 5777.9 5783.7 5802.2 5804.1 5432.7 5583.7 5607.4 5614.2 5621.5 21:26:20 INFO - PID 3486 | 21:26:20 INFO - PID 3486 | [#5] yui.html Cycles:180 Average:15367.24 Median:3403.84 stddev:18082.60 (531.2%) stddev-sans-first:18099.59 21:26:20 INFO - PID 3486 | Values: 659.3 667.0 667.6 744.1 746.6 13167.7 13577.2 13595.5 16230.3 16918.5 16106.7 16121.0 16165.9 16171.0 16352.5 900.5 905.6 907.3 907.3 910.4 903.2 904.8 909.1 909.2 909.3 939.1 944.9 946.3 948.1 948.6 943.5 948.1 950.2 951.8 953.2 634.5 674.8 680.6 686.2 701.9 14149.4 14306.5 14328.4 14476.5 14486.0 14981.9 15970.0 15993.5 16092.8 16132.9 12105.2 12375.1 12471.8 12472.5 12489.3 2685.6 2716.9 2717.3 2719.4 2727.8 69478.7 69487.7 69574.0 69895.7 71187.0 11092.9 11950.3 12004.3 12198.9 12270.3 17656.4 21922.6 22409.0 22448.4 22581.3 6073.1 6219.6 6229.0 6230.1 6270.3 2870.3 2914.2 2920.3 2920.9 2929.8 3324.5 3329.8 3397.3 3410.4 3411.3 679.5 684.6 688.7 690.0 692.0 482.5 483.6 486.3 497.1 501.9 9002.2 9655.1 9718.4 9789.4 9934.7 553.8 556.3 556.7 558.7 564.5 4216.6 4389.8 4448.2 4518.1 4565.8 60559.4 61125.1 62183.0 62238.4 64053.7 53520.0 54450.2 55360.4 55362.2 55465.0 51279.2 52535.2 52750.7 53027.5 56260.4 9715.3 10721.5 11178.4 11438.5 11721.4 24513.5 24525.8 25285.7 25310.2 25476.0 40001.2 40436.6 40830.6 41762.6 46237.1 12833.7 12855.6 12910.5 12962.2 12970.7 15721.8 16084.6 16092.0 16227.0 16272.9 13777.9 14234.1 14417.1 14604.9 14630.0 13518.6 13886.2 13976.3 14028.4 14094.9 13322.7 14159.9 14207.3 14251.2 14572.3 9762.9 10270.2 10291.9 10553.4 11090.1 10521.2 10599.7 10640.4 11347.1 11356.9 21:26:20 INFO - PID 3486 | -------- Summary: end -------- 21:26:20 INFO - PID 3486 | 21:26:20 INFO - TEST-INFO | 3486: exit 0 21:26:20 INFO - TEST-OK | dromaeo_css | took 1120715ms 21:26:20 INFO - TEST-START | kraken 21:26:20 INFO - operating with platform_type : linux_ 21:26:20 INFO - Initialising browser for kraken test... 21:26:20 INFO - TEST-INFO | started process 3904 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE1oOYy/profile http://localhost:34338/getInfo.html) 21:26:21 INFO - PID 3904 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2941: String.localeCompare is deprecated; use String.prototype.localeCompare instead 21:26:24 INFO - PID 3904 | __metrics Screen width/height:1600/1200 21:26:24 INFO - PID 3904 | colorDepth:24 21:26:24 INFO - PID 3904 | Browser inner width/height: 1024/695 21:26:24 INFO - PID 3904 | __metrics 21:26:26 INFO - TEST-INFO | 3904: exit 0 21:26:26 INFO - Browser initialized. 21:26:26 INFO - Running cycle 1/1 for kraken test... 21:26:26 INFO - TEST-INFO | started process 4088 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpE1oOYy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:26:38 INFO - PID 4088 | RSS: Main: 169062400 21:26:38 INFO - PID 4088 | 21:26:41 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34338/tests/kraken/driver.html?testName=audio-beat-detection) 21:26:42 INFO - PID 4088 | RSS: Main: 172404736 21:26:42 INFO - PID 4088 | 21:26:44 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34338/tests/kraken/driver.html?testName=audio-dft) 21:26:45 INFO - PID 4088 | RSS: Main: 171986944 21:26:45 INFO - PID 4088 | 21:26:48 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34338/tests/kraken/driver.html?testName=audio-fft) 21:26:48 INFO - PID 4088 | RSS: Main: 168153088 21:26:48 INFO - PID 4088 | 21:26:51 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34338/tests/kraken/driver.html?testName=audio-oscillator) 21:26:51 INFO - PID 4088 | RSS: Main: 169197568 21:26:51 INFO - PID 4088 | 21:26:53 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34338/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:26:54 INFO - PID 4088 | RSS: Main: 169119744 21:26:54 INFO - PID 4088 | 21:26:57 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34338/tests/kraken/driver.html?testName=imaging-darkroom) 21:26:58 INFO - PID 4088 | RSS: Main: 173428736 21:26:58 INFO - PID 4088 | 21:27:01 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34338/tests/kraken/driver.html?testName=imaging-desaturate) 21:27:02 INFO - PID 4088 | RSS: Main: 171216896 21:27:02 INFO - PID 4088 | 21:27:05 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34338/tests/kraken/driver.html?testName=json-parse-financial) 21:27:06 INFO - PID 4088 | RSS: Main: 171896832 21:27:06 INFO - PID 4088 | 21:27:07 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34338/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:27:08 INFO - PID 4088 | RSS: Main: 172412928 21:27:08 INFO - PID 4088 | 21:27:10 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34338/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:27:10 INFO - PID 4088 | RSS: Main: 172421120 21:27:10 INFO - PID 4088 | 21:27:12 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34338/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:27:13 INFO - PID 4088 | RSS: Main: 172191744 21:27:13 INFO - PID 4088 | 21:27:16 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:27:17 INFO - PID 4088 | RSS: Main: 172273664 21:27:17 INFO - PID 4088 | 21:27:20 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:27:20 INFO - PID 4088 | RSS: Main: 172158976 21:27:20 INFO - PID 4088 | 21:27:22 INFO - PID 4088 | Cycle 1(1): loaded http://localhost:34338/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34338/tests/kraken/driver.html?testName=ai-astar) 21:27:22 INFO - PID 4088 | RSS: Main: 173604864 21:27:22 INFO - PID 4088 | 21:27:22 INFO - PID 4088 | __start_tp_report 21:27:22 INFO - PID 4088 | _x_x_mozilla_page_load 21:27:22 INFO - PID 4088 | _x_x_mozilla_page_load_details 21:27:22 INFO - PID 4088 | |i|pagename|runs| 21:27:22 INFO - PID 4088 | |0;ai-astar;103;111;112;110;113;111;112;113;112;113 21:27:22 INFO - PID 4088 | |1;audio-beat-detection;149;124;123;167;123;131;123;127;150;125 21:27:22 INFO - PID 4088 | |2;audio-dft;162;165;165;162;166;165;184;173;163;162 21:27:22 INFO - PID 4088 | |3;audio-fft;75;76;76;103;75;84;74;77;98;77 21:27:22 INFO - PID 4088 | |4;audio-oscillator;83;85;111;84;84;83;96;84;84;108 21:27:22 INFO - PID 4088 | |5;imaging-gaussian-blur;118;115;115;115;113;114;115;115;114;114 21:27:22 INFO - PID 4088 | |6;imaging-darkroom;151;150;150;154;150;152;151;150;150;150 21:27:22 INFO - PID 4088 | |7;imaging-desaturate;95;102;94;94;94;95;95;96;95;98 21:27:22 INFO - PID 4088 | |8;json-parse-financial;55;64;56;55;59;59;58;55;55;57 21:27:22 INFO - PID 4088 | |9;json-stringify-tinderbox;55;56;56;56;56;56;56;56;55;57 21:27:22 INFO - PID 4088 | |10;stanford-crypto-aes;86;83;84;84;87;85;82;82;84;82 21:27:22 INFO - PID 4088 | |11;stanford-crypto-ccm;135;137;144;138;140;133;133;131;229;136 21:27:22 INFO - PID 4088 | |12;stanford-crypto-pbkdf2;182;199;207;190;192;188;191;197;189;191 21:27:22 INFO - PID 4088 | |13;stanford-crypto-sha256-iterative;74;76;75;74;72;74;75;74;72;72 21:27:22 INFO - PID 4088 | __end_tp_report 21:27:22 INFO - PID 4088 | __start_cc_report 21:27:22 INFO - PID 4088 | _x_x_mozilla_cycle_collect,760 21:27:22 INFO - PID 4088 | __end_cc_report 21:27:22 INFO - PID 4088 | __startTimestamp1495168042976__endTimestamp 21:27:22 INFO - PID 4088 | 21:27:22 INFO - PID 4088 | ------- Summary: start ------- 21:27:22 INFO - PID 4088 | Number of tests: 14 21:27:22 INFO - PID 4088 | 21:27:22 INFO - PID 4088 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.98 (2.7%) stddev-sans-first:1.05 21:27:22 INFO - PID 4088 | Values: 103.0 111.0 112.0 110.0 113.0 111.0 112.0 113.0 112.0 113.0 21:27:22 INFO - PID 4088 | 21:27:22 INFO - PID 4088 | [#1] audio-beat-detection Cycles:10 Average:134.20 Median:129.00 stddev:15.53 (12.0%) stddev-sans-first:15.53 21:27:22 INFO - PID 4088 | Values: 149.0 124.0 123.0 167.0 123.0 131.0 123.0 127.0 150.0 125.0 21:27:22 INFO - PID 4088 | 21:27:22 INFO - PID 4088 | [#2] audio-dft Cycles:10 Average:166.70 Median:165.00 stddev:6.90 (4.2%) stddev-sans-first:7.10 21:27:22 INFO - PID 4088 | Values: 162.0 165.0 165.0 162.0 166.0 165.0 184.0 173.0 163.0 162.0 21:27:22 INFO - PID 4088 | 21:27:22 INFO - PID 4088 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.50 stddev:10.45 (13.7%) stddev-sans-first:10.81 21:27:22 INFO - PID 4088 | Values: 75.0 76.0 76.0 103.0 75.0 84.0 74.0 77.0 98.0 77.0 21:27:22 INFO - PID 4088 | 21:27:22 INFO - PID 4088 | [#4] audio-oscillator Cycles:10 Average:90.20 Median:84.00 stddev:10.89 (13.0%) stddev-sans-first:11.24 21:27:22 INFO - PID 4088 | Values: 83.0 85.0 111.0 84.0 84.0 83.0 96.0 84.0 84.0 108.0 21:27:22 INFO - PID 4088 | 21:27:22 INFO - PID 4088 | [#5] imaging-gaussian-blur Cycles:10 Average:114.80 Median:115.00 stddev:1.32 (1.1%) stddev-sans-first:0.73 21:27:22 INFO - PID 4088 | Values: 118.0 115.0 115.0 115.0 113.0 114.0 115.0 115.0 114.0 114.0 21:27:22 INFO - PID 4088 | 21:27:22 INFO - PID 4088 | [#6] imaging-darkroom Cycles:10 Average:150.80 Median:150.50 stddev:1.32 (0.9%) stddev-sans-first:1.39 21:27:22 INFO - PID 4088 | Values: 151.0 150.0 150.0 154.0 150.0 152.0 151.0 150.0 150.0 150.0 21:27:22 INFO - PID 4088 | 21:27:22 INFO - PID 4088 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:95.00 stddev:2.49 (2.6%) stddev-sans-first:2.62 21:27:22 INFO - PID 4088 | Values: 95.0 102.0 94.0 94.0 94.0 95.0 95.0 96.0 95.0 98.0 21:27:22 INFO - PID 4088 | 21:27:22 INFO - PID 4088 | [#8] json-parse-financial Cycles:10 Average:57.30 Median:57.50 stddev:2.87 (5.0%) stddev-sans-first:2.92 21:27:22 INFO - PID 4088 | Values: 55.0 64.0 56.0 55.0 59.0 59.0 58.0 55.0 55.0 57.0 21:27:22 INFO - PID 4088 | 21:27:22 INFO - PID 4088 | [#9] json-stringify-tinderbox Cycles:10 Average:55.90 Median:56.00 stddev:0.57 (1.0%) stddev-sans-first:0.50 21:27:22 INFO - PID 4088 | Values: 55.0 56.0 56.0 56.0 56.0 56.0 56.0 56.0 55.0 57.0 21:27:22 INFO - PID 4088 | 21:27:22 INFO - PID 4088 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:1.73 (2.1%) stddev-sans-first:1.66 21:27:22 INFO - PID 4088 | Values: 86.0 83.0 84.0 84.0 87.0 85.0 82.0 82.0 84.0 82.0 21:27:22 INFO - PID 4088 | 21:27:22 INFO - PID 4088 | [#11] stanford-crypto-ccm Cycles:10 Average:145.60 Median:137.50 stddev:29.55 (21.5%) stddev-sans-first:31.09 21:27:22 INFO - PID 4088 | Values: 135.0 137.0 144.0 138.0 140.0 133.0 133.0 131.0 229.0 136.0 21:27:22 INFO - PID 4088 | 21:27:22 INFO - PID 4088 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.60 Median:191.50 stddev:6.88 (3.6%) stddev-sans-first:6.14 21:27:22 INFO - PID 4088 | Values: 182.0 199.0 207.0 190.0 192.0 188.0 191.0 197.0 189.0 191.0 21:27:22 INFO - PID 4088 | 21:27:22 INFO - PID 4088 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.80 Median:74.00 stddev:1.40 (1.9%) stddev-sans-first:1.48 21:27:22 INFO - PID 4088 | Values: 74.0 76.0 75.0 74.0 72.0 74.0 75.0 74.0 72.0 72.0 21:27:22 INFO - PID 4088 | -------- Summary: end -------- 21:27:22 INFO - PID 4088 | 21:27:23 INFO - TEST-INFO | 4088: exit 0 21:27:24 INFO - TEST-OK | kraken | took 63202ms 21:27:24 INFO - SUITE-END | took 1183s 21:27:24 INFO - Completed test suite (00:19:43) 21:27:24 INFO - javascript benchmark 21:27:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6791.3901570748285, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2705.715899830518, 2725.9591106133425, 2727.645406097207, 2748.106865268787, 2764.115483045424, 5273.630845840793, 5318.122509785885, 5324.068288049591, 5325.973370133153, 5370.3287089113865, 5332.200169974506, 5342.038433082043, 5412.404635490093, 5423.2136340230745, 5430.8913821723545, 4473.172463094322, 4664.97667511662, 4697.17799385108, 4711.858644240661, 4770.189067858455, 4711.458182309027, 4751.144793937107, 4769.427668679763, 4770.6422018348585, 4791.904161916759, 4648.837290694843, 4671.27595222741, 4671.696339737906, 4691.929621055687, 4764.2615394613895, 4711.811527538895, 4745.383100196987, 4768.49930757269, 4781.6891902026255, 4802.255650374198, 4685.906281874343, 4688.226442636961, 4715.7877895494785, 4717.952820471785, 4757.6907501012665, 5208.114620514521, 5324.92012619811, 5327.334083239595, 5330.28041214435, 5351.063563876306, 5664.20701101846, 5696.287964004499, 5733.942660573424, 5767.538596912237, 5771.595988280822, 5776.0, 5778.508826749689, 5788.82633520995, 5789.710514474259, 5795.3045634523705, 5320.893582128336, 5348.411674715817, 5348.414260445001, 5356.384015838151, 5367.490088441592, 5820.185174075633, 5900.734466948998, 5903.498202652822, 5909.6158749681135, 5909.940900590939, 5603.719814009283, 5612.0, 5624.3813180550105, 5710.400407957188, 5720.0, 5783.1325301204315, 5786.218860453869, 5797.0, 5803.245578074908, 5819.098039803837, 5627.831165065055, 5731.541476681856, 5748.109043098327, 5754.251947246831, 5757.078867381283, 5622.353429355677, 5739.253896993364, 5749.425057494301, 5752.9712351437975, 5755.165501002415, 4720.905581888343, 4736.360591320127, 4798.0, 4807.399075115611, 4809.254565542346, 4107.979460102681, 4109.9589004109575, 4112.0, 4116.670666346685, 4154.169166166718, 4763.571278584944, 4843.806247750121, 4849.078675051729, 4863.7324947128245, 4875.756212189376, 5579.860503487445, 5632.52123569493, 5646.745896434671, 5649.54803615718, 5673.602847800615, 4799.880002999883, 4816.686915350491, 4837.830675926326, 4858.17411040124, 4880.731559764247, 5064.037832811754, 5079.644424890296, 5083.898322033612, 5084.466131056186, 5099.694018358836, 5177.637565370388, 5246.580273578181, 5248.60635452335, 5250.212468129811, 5354.223637572608, 5605.1872478491205, 5668.744906479136, 5679.403662615366, 5686.976344257908, 5688.914666280092, 5365.275687782099, 5366.034113859543, 5368.0, 5384.192371144203, 5384.703841288767, 5603.607747457639, 5636.802711905064, 5666.320041595035, 5679.971600141973, 5681.573881958952, 5673.517750991047, 5796.82609521715, 5805.76776928935, 5815.534757219328, 5823.0, 5501.202325662836, 5538.252335934597, 5594.356648985418, 5646.3506696728755, 5667.40492248308, 5602.971985140048, 5612.186232996111, 5613.803516876889, 5617.550595952396, 5641.097424412238, 5380.192971054373, 5470.234167216672, 5532.889342213214, 5536.169574563686, 5543.9168412474655, 5456.863578410572, 5557.972210138923, 5561.4716601922755, 5629.915551266652, 5690.573207009408, 5471.0, 5473.452654734495, 5475.4250803665045, 5484.890302194013, 5541.778328866801], "value": 5189.503135788944, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [685.8148299959012, 744.3301029073833, 762.5158024654345, 1067.9519421626026, 1083.5070043130368, 32239.51640725391, 33640.0, 33669.158271043234, 33669.158271043234, 33737.83131084341, 35719.82140089296, 36105.27789444216, 36127.4580881287, 36160.276794464095, 36234.63765362352, 6926.584404935695, 6954.8261293467685, 7103.289671032881, 7142.535735177223, 7161.928380716205, 7024.789256322319, 7169.318914703095, 7180.17427995782, 7194.352508274254, 7198.172210195816, 7097.325754053357, 7197.460190485708, 7225.313595208447, 7225.927740722578, 7240.565566066027, 7188.8202794930285, 7192.568445893211, 7221.675024623904, 7227.674754636054, 7234.927650723478, 7084.362407383309, 7114.039604653357, 7120.038794762692, 7123.715051397938, 7136.393406560397, 32185.0, 32215.677843221503, 32231.0, 32271.67728322734, 32304.19239519007, 3054.69453054695, 3085.475469170224, 3100.193949573105, 3123.04747052149, 3125.7030582094662, 24574.63138052913, 24575.63136552953, 24606.384840379134, 24638.0, 24725.629115563283, 3121.797083189608, 3131.264152924061, 3145.2294187923876, 3149.2599239178776, 3179.72972297355, 139793.0, 140313.0, 148525.2573737135, 151518.0, 153177.0, 39928.800355998035, 39966.0, 40005.39991900066, 40063.0, 40178.19643607111, 40769.18461630751, 40935.38596921049, 41022.0, 41196.38205426921, 41311.0, 11975.940120299343, 12060.819087713691, 12063.939680301542, 12075.939620301842, 12080.033597312195, 9587.568559414703, 9609.375390599589, 9613.134817866287, 9625.807483850283, 9632.0, 12712.809307860205, 12815.29515876617, 12823.61529154127, 12851.100422970303, 12854.357282135856, 5474.151506516497, 5532.0, 5539.7784088636, 5587.078132108157, 5627.746751396197, 874.1477059866579, 880.4101252161067, 902.9909700903038, 913.4291068082448, 931.725141083382, 20259.791967351637, 21041.15835366599, 21353.78646213549, 21504.247351342627, 21529.56940861174, 972.3825370889394, 973.9805203896024, 976.6288810252058, 998.7752755630071, 1005.8591797148405, 11177.329360238411, 11179.0, 11333.773324533464, 11425.200235983568, 11459.828102578467, 161000.0, 162446.0, 163672.0, 163841.0, 165126.0, 40945.1810963785, 41146.58853411428, 41207.58792412098, 41287.0, 41343.58656413457, 1217.3852204636603, 1234.7653945750458, 1236.2644226685109, 1241.075398827861, 1253.2417887178308, 19731.506712332306, 19735.0, 20223.19107235694, 21047.368578942656, 21199.470013249793, 29849.850750746107, 29859.70140298569, 29872.25319366946, 29874.0, 29911.70088299176, 138702.0, 138778.30610846882, 138869.3056534711, 139066.74199661243, 139301.0, 28882.855585721936, 29181.7081829179, 29258.414831703674, 30975.690243098183, 30991.0, 36503.634963651086, 37203.06992325214, 37224.06939826526, 37472.62527374691, 37476.43785343168, 26190.0, 27239.72760272372, 27370.589441158798, 27675.86162069177, 28165.43669126647, 27457.31356716098, 28130.0, 28241.01156459514, 29138.27154321159, 29170.27074323074, 30777.846110769304, 30875.536866947463, 30904.0, 30994.0, 31050.223744406572, 26766.866165669046, 26824.463510730067, 27783.722162778115, 28021.719782801913, 28774.42451151007, 20386.59226815485, 22639.094436223026, 22817.885910571003, 22976.4255893604, 23137.0], "value": 14556.616934123358, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [413.9441175441318, 418.13380281690127, 431.8682801745467, 440.50663257151984, 442.55081092690926, 17023.744643830352, 17082.14589270536, 17258.223379947918, 17809.376671816488, 17876.284948602057, 17104.230309636067, 17194.82805171948, 18600.627987440243, 18985.14566844492, 19185.232590696356, 5303.549198318147, 5500.697461639608, 5518.420565840599, 5559.11054231323, 5676.2620859288445, 5491.0, 5497.505224529791, 5506.091494903336, 5522.696251706155, 5524.751386187611, 5357.517823395893, 5401.864953376177, 5433.646812957145, 5446.645968012067, 5460.399356070829, 5433.266509021271, 5464.316960379932, 5479.1781232815, 5486.067368547337, 5493.395726470125, 4872.171730805771, 4954.529319714621, 4986.750662466899, 4992.975035124801, 5005.6496045276845, 22320.665190022162, 22442.77557224423, 22532.774672253232, 22600.095996160133, 22700.65949010766, 1612.46788559775, 1685.4522280258966, 1694.4747128390238, 1695.5252529291818, 1696.2621259752048, 14448.927755361261, 14899.553013409615, 15136.0, 15245.771313430307, 15292.158931258777, 1981.395674319332, 2028.8985550722552, 2065.0913598016823, 2070.285751415774, 2084.6351888419467, 77886.0, 84432.99999999939, 86853.56573217157, 91112.99999999933, 92351.53824230836, 11065.446727663746, 11262.959001069828, 17369.56576085608, 17747.0, 17939.192736326637, 32916.50625240623, 32983.50524742131, 32989.3402131956, 33018.834905825315, 33077.503837442455, 8412.411131220755, 8773.034966153718, 8880.555972201364, 9010.14403631654, 9156.175944165057, 6584.144061272004, 6702.296258892746, 6970.0, 7118.750843720445, 7135.423089254425, 9404.95297523508, 9490.488519247923, 9506.85739713891, 9522.95238523803, 9642.841080022296, 3801.467794508771, 3996.2407142642805, 4013.8823000674374, 4030.214108248922, 4035.394690796404, 862.8490014247482, 889.217488610019, 893.6246776353947, 898.5417437107122, 920.4845286639503, 16891.493255202364, 16918.661626767396, 17435.12824358777, 17686.439667845203, 17718.91140544289, 885.6147575804546, 892.8169725206317, 899.4738078224182, 900.8063266397756, 908.9454632722058, 9341.90658093424, 9587.651025498797, 9784.608615655436, 9867.699000259323, 9872.506374681238, 321236.0, 358339.0, 360320.0, 364291.0, 368066.0, 74535.0, 77485.37719342143, 77746.0, 78015.60992195003, 79923.0, 1087.1954753482523, 1118.7370967822555, 1127.9492422840992, 1129.5820546397722, 1129.5989923577013, 17432.128393580017, 17736.91131544334, 18441.354552590594, 18465.9076704621, 18724.157412916724, 37333.22720896272, 37680.81159594184, 38823.417648735856, 38995.41506877456, 40580.1883962325, 46842.53157468382, 47447.05105897932, 47808.0, 47878.760606196745, 47937.760311198224, 8075.757727268191, 8111.107778144281, 8211.95894020526, 8240.0, 8309.421209970327, 11616.419179041182, 12167.39163041862, 12927.482900683868, 12947.741045179233, 13150.60548183556, 11419.486123124645, 11461.255018423775, 11731.706707332043, 11772.941135294268, 11955.64133076009, 10862.837057443987, 10907.127429805756, 10926.50830712604, 11014.559417623206, 11340.09279257674, 11265.817089205515, 12032.879671203526, 12145.210561313486, 12145.757084858431, 12311.138220324492, 8068.233517815798, 8259.669613215405, 8265.95867020661, 8423.8736418955, 8546.09242800926, 11124.555017799197, 11144.832827507757, 11217.270877392943, 11319.320840749582, 11337.433128343715], "value": 9476.135756063071, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1209.9818502722458, 1281.3273031658373, 1287.6845172932633, 1288.6262983734716, 1296.533248030709, 10070.345427547205, 10546.0, 10564.524596393152, 10567.735806604838, 10800.0, 10636.840447393275, 10786.73033174171, 10821.242513024092, 10824.458777061154, 10843.349399036064, 2169.078141789741, 2214.756376798559, 2218.245796429214, 2221.7556068832414, 2227.042371780134, 2172.8261739060836, 2215.29110684581, 2216.7229096362953, 2220.9777902221012, 2222.14447437736, 2089.550746589483, 2135.444784356063, 2149.7312835895514, 2155.5473350596317, 2165.9025343859485, 2117.6082424751394, 2128.8935553222277, 2158.719366482355, 2161.848670593059, 2174.097749433983, 1920.193518722126, 2056.5784014277037, 2178.313831143201, 2209.4586826227514, 2210.5910406574835, 10235.744106397326, 10271.897281027168, 10272.0, 10378.716682329876, 10383.065524102867, 5225.242339860737, 5383.596230282745, 5398.352197736297, 5408.378036525811, 5409.972950135263, 3068.2789544457037, 3217.9034628961167, 3302.3560405720896, 3308.3052558962645, 3338.88313909012, 1055.3562326980536, 1079.5411949921252, 1097.4732128578248, 1158.7161145519317, 1163.098598586094, 15432.38270469191, 15594.220288985618, 15599.92200039004, 15607.531774046796, 15620.297086631015, 4405.845795397146, 4595.747233902168, 4615.076984603025, 4648.535146485325, 4678.274867395559, 10926.672199834018, 10951.069159121405, 10958.616448424267, 10965.780684386267, 10978.890211097947, 5411.080116380225, 5415.918761218585, 5416.91874621881, 5418.485243901901, 5429.972850135724, 4744.264638980963, 4975.800967961313, 5070.721110338966, 5093.770780314895, 5112.488751124932, 3647.9635203648154, 3800.1259710266795, 3811.7522361046445, 3860.092878173627, 3904.4143378492886, 1133.6259034518755, 1136.4488223211736, 1152.2428296847374, 1152.8040233160382, 1168.9064874809994, 698.7798843364324, 723.1322413104191, 726.0561270348526, 727.5016613619688, 740.2486476226634, 5391.137418013099, 5463.562914966793, 5502.064649009598, 5592.350256674291, 5638.210650508932, 535.1197280473599, 550.4852962480094, 551.2613098448019, 553.6594994078613, 558.1126009644685, 3331.1179183761096, 4042.2521833460314, 4280.4863416390235, 4333.0, 4406.7576283304725, 12965.481380744664, 13611.183329000292, 13640.113392629448, 13649.590512284647, 13662.316884155753, 13023.0, 13394.062415631008, 13406.262655554037, 13579.52471663487, 13585.796213056812, 7096.858062838714, 7227.710891564278, 7259.237780033126, 7277.927220727831, 7285.817854553678, 5915.556333275108, 6141.232345956755, 6218.689065546795, 6230.50155987529, 6414.967925160345, 11509.366984815915, 11606.0, 11733.530658773554, 12026.639200823989, 12114.515419383479, 11811.515602896994, 12039.337836419081, 12073.818892716792, 12181.634550963485, 12270.202436841577, 8298.21166989135, 8488.10874858131, 8488.702895398632, 8501.362397820065, 8514.446560973516, 9442.48066356357, 9570.377925434825, 9572.282078843975, 9741.951290243504, 9827.606895724091, 8228.177182281963, 8256.339492840678, 8327.20891515305, 8385.245327920517, 8419.158084191531, 7916.4062695299235, 8054.194580541899, 8118.066422361504, 8128.9593552031865, 8334.583270836556, 6968.303169682991, 7106.715731370894, 7185.964070179615, 7196.4962452627815, 7211.134663840163, 5120.923186152137, 5125.8974820502635, 5189.143791274398, 5265.499777521282, 5283.9432113578205, 5286.20706893969, 5345.893082138413, 5359.410464848941, 5410.080286351251, 5525.475079867406], "value": 4688.77215037518, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.86284800319885, 393.63195412289514, 397.4296883971499, 398.18769709792025, 398.2433376584489, 5482.643628164172, 5494.697791621459, 5503.229547863302, 5535.197396377528, 5537.501624853768, 4890.584300334476, 5365.731713414323, 5401.460583733637, 5401.756920938557, 5409.134538473845, 4255.787210639471, 4263.467066616665, 4270.231358355495, 4281.336392859112, 4282.207791558556, 4276.700630955835, 4280.507741609724, 4298.118885628439, 4303.0, 4303.612674859262, 4172.499300083994, 4245.660347172235, 4261.296886013804, 4263.509696384909, 4273.957260427387, 4211.115665710205, 4218.219629368546, 4223.21870453967, 4225.746455212697, 4234.30134027885, 3848.4804551385487, 3853.499045124116, 3856.382978723391, 3873.225354928997, 3884.8251828667776, 5220.791168353261, 5278.234655974862, 5284.07528682479, 5298.629095963284, 5331.0, 5053.418856831438, 5057.924131138036, 5075.162598171334, 5094.414142373637, 5109.540141387293, 5758.309002919635, 5768.3654797972185, 5771.365149833515, 5773.480386765169, 5779.595428320019, 4238.470191226097, 4343.9140214946265, 4368.213721530124, 4389.100234451929, 4392.165488557164, 5837.29952405714, 5953.374895635982, 5962.314333851619, 5966.3138739045135, 5984.910226346608, 3967.175099454226, 3973.6225058619384, 3976.204759048202, 3978.5026871641044, 4010.6991975601945, 4044.7775372354213, 4049.0889549851636, 4054.8986275342763, 4064.7967601620394, 4075.612816782401, 4610.723356598614, 4727.101850648434, 4735.621150307967, 4740.3837501124635, 4743.739094349844, 5723.77104915807, 5729.627574207663, 5736.827895163152, 5739.540836733051, 5756.280464941882, 1416.178616402484, 1437.5974727076436, 1438.4605772835187, 1439.632893612143, 1441.978370324446, 890.8307421589877, 934.8270569944445, 949.050949050949, 950.496236994394, 959.8625628630095, 4934.111859865258, 4937.506249375034, 4943.110240156806, 4944.456109827988, 4961.479044700327, 5899.941000590025, 5930.8813823723285, 5932.940670593325, 5938.376470470625, 5957.255343082114, 4791.784369703371, 4846.636502262344, 4905.901881962341, 4918.213085906309, 4941.431735350408, 3094.4275309067443, 3122.98438507806, 3128.593282873212, 3128.9530657040164, 3132.3578666373337, 5416.241726158341, 5447.5641948644015, 5479.890402191933, 5497.5601951843755, 5504.422035686275, 5855.268091488564, 6065.696715164224, 6114.877702445926, 6115.4099934016585, 6124.479419249325, 5476.863078423071, 5488.69812160335, 5492.80775172875, 5509.807156749494, 5522.116461366242, 5818.592698511064, 5907.32065812437, 5925.762969481172, 5929.258842644669, 5998.9100163496705, 5846.473817356458, 5847.1229315603, 5864.413558644102, 5869.119632055055, 5901.468867801918, 5272.182811664198, 5460.2355670207, 5486.972565137149, 5505.229267902417, 5515.0, 4029.133736246721, 4073.6741060715663, 4083.040485485849, 4088.0801819590356, 4094.0992981544014, 5869.559783016376, 5958.867815115114, 5963.7912673056235, 5967.313758917607, 5987.970060149672, 5757.107648314518, 5757.884842303214, 5790.044642634087, 5793.710314484343, 5803.0, 5745.626534275259, 5753.424657534213, 5767.221425107557, 5790.681512516852, 5811.215485909348, 5443.8094666686475, 5610.298712660918, 5668.886622267449, 5680.744366503434, 5681.829545113653, 5767.307923049261, 5777.873314703593, 5783.652980821164, 5802.158686990447, 5804.053243794092, 5432.674039557639, 5583.664980101207, 5607.3551541571605, 5614.24207731951, 5621.54709931366], "value": 4323.559120773306, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.3307792590522, 666.9666516674165, 667.5560752099852, 744.1182199094077, 746.6042997211476, 13167.6708082298, 13577.185368877861, 13595.52415665452, 16230.269637866295, 16918.49244522663, 16106.677866442693, 16121.0, 16165.919170404131, 16171.0, 16352.509424717247, 900.5092224737501, 905.5879574793453, 907.2923119966437, 907.3285768531273, 910.4127837544779, 903.2006674093409, 904.7557159566913, 909.1272378516632, 909.236241557092, 909.2634965677789, 939.1453777062874, 944.8724422202984, 946.3375637054055, 948.0803620488116, 948.6395169835453, 943.5046600534705, 948.1419315519466, 950.2160717408132, 951.7953639967371, 953.1850268020812, 634.5177664974607, 674.790814847394, 680.6222546486698, 686.2005763285766, 701.9403350715195, 14149.434022639081, 14306.499272525412, 14328.426862925471, 14476.493322733653, 14486.0, 14981.925090374587, 15970.0, 15993.520194394187, 16092.75860862088, 16132.919335403365, 12105.213161144497, 12375.071869609725, 12471.812922806164, 12472.50109995599, 12489.313087780169, 2685.610586464971, 2716.877740501682, 2717.279920820984, 2719.3745438549245, 2727.8226915250443, 69478.65260673715, 69487.65256173686, 69574.0, 69895.65052174758, 71187.0, 11092.944535277273, 11950.282983021047, 12004.279743215435, 12198.939005304917, 12270.2637841728, 17656.382026629264, 21922.561548768936, 22409.0, 22448.43878903008, 22581.322560323217, 6073.1497590337385, 6219.626822390671, 6229.034499652561, 6230.127782110508, 6270.31026587075, 2870.2680816391685, 2914.184028472031, 2920.269932516871, 2920.8831646734316, 2929.838858862783, 3324.4680851063713, 3329.816860072671, 3397.3375191837354, 3410.3520331137006, 3411.283630437636, 679.5209377388929, 684.6405637040494, 688.6900894597451, 689.9827504312433, 692.0415224913531, 482.4500069920294, 483.61794182595355, 486.2536007228957, 497.107691693404, 501.9171836646912, 9002.23481004122, 9655.082767137252, 9718.416894986323, 9789.412635241908, 9934.701958941243, 553.8117040206349, 556.2907293201201, 556.7299859568107, 558.6871352042868, 564.51169738177, 4216.578342165759, 4389.780510974502, 4448.177087238806, 4518.073794872043, 4565.794539245742, 60559.39440605538, 61125.08312375318, 62183.0, 62238.37761622326, 64053.67973160104, 53520.0, 54450.18324725132, 55360.44639553553, 55362.16956745652, 55465.0, 51279.230811537855, 52535.211971820456, 52750.73624631929, 53027.469725303796, 56260.43739562552, 9715.27135464857, 10721.517531710935, 11178.385188814367, 11438.542458301576, 11721.355325457182, 24513.509729804948, 24525.754742452347, 25285.74714252834, 25310.240692779247, 25476.0, 40001.199975999734, 40436.59563404446, 40830.59169408268, 41762.58237417709, 46237.07525849397, 12833.743325133632, 12855.614331570068, 12910.548130815376, 12962.22226666403, 12970.675733106747, 15721.764173537178, 16084.597885052968, 16091.954022988468, 16227.0, 16272.918635406748, 13777.931110344383, 14234.14595124296, 14417.13497190172, 14604.926975365055, 14630.049046811922, 13518.59444216675, 13886.166829990232, 13976.301184940916, 14028.368723407268, 14094.929525352307, 13322.666933326356, 14159.858401415853, 14207.28963551839, 14251.21618311003, 14572.344244508811, 9762.85355719679, 10270.229732770222, 10291.897081029394, 10553.366797992145, 11090.112790976542, 10521.158307335549, 10599.735006624587, 10640.40393940915, 11347.148963827582, 11356.94321528387], "value": 6760.846614548585, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1554.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 111.0, 112.0, 110.0, 113.0, 111.0, 112.0, 113.0, 112.0, 113.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 124.0, 123.0, 167.0, 123.0, 131.0, 123.0, 127.0, 150.0, 125.0], "value": 134.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 165.0, 162.0, 166.0, 165.0, 184.0, 173.0, 163.0, 162.0], "value": 166.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 103.0, 75.0, 84.0, 74.0, 77.0, 98.0, 77.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 85.0, 111.0, 84.0, 84.0, 83.0, 96.0, 84.0, 84.0, 108.0], "value": 90.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 115.0, 115.0, 115.0, 113.0, 114.0, 115.0, 115.0, 114.0, 114.0], "value": 114.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 150.0, 150.0, 154.0, 150.0, 152.0, 151.0, 150.0, 150.0, 150.0], "value": 150.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 102.0, 94.0, 94.0, 94.0, 95.0, 95.0, 96.0, 95.0, 98.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 64.0, 56.0, 55.0, 59.0, 59.0, 58.0, 55.0, 55.0, 57.0], "value": 57.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 56.0, 55.0, 57.0], "value": 55.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 84.0, 84.0, 87.0, 85.0, 82.0, 82.0, 84.0, 82.0], "value": 83.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 137.0, 144.0, 138.0, 140.0, 133.0, 133.0, 131.0, 229.0, 136.0], "value": 145.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 199.0, 207.0, 190.0, 192.0, 188.0, 191.0, 197.0, 189.0, 191.0], "value": 192.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 76.0, 75.0, 74.0, 72.0, 74.0, 75.0, 74.0, 72.0, 72.0], "value": 73.8, "unit": "score"}]}]} 21:27:24 INFO - Return code: 0 21:27:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:27:24 INFO - # TBPL SUCCESS # 21:27:24 INFO - Running post-action listener: _resource_record_post_action 21:27:24 INFO - [mozharness: 2017-05-19 04:27:24.287018Z] Finished run-tests step (success) 21:27:24 INFO - Running post-run listener: _resource_record_post_run 21:27:24 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 8126464; Write bytes: 448937984; Read time: 2140; Write time: 334952 21:27:24 INFO - TinderboxPrint: CPU usage
13.3% 21:27:24 INFO - TinderboxPrint: I/O read bytes / time
8,126,464 / 2,140 21:27:24 INFO - TinderboxPrint: I/O write bytes / time
448,937,984 / 334,952 21:27:24 INFO - TinderboxPrint: CPU idle
8,312.2 (86.6%) 21:27:24 INFO - TinderboxPrint: CPU user
1,220.0 (12.7%) 21:27:24 INFO - TinderboxPrint: Swap in / out
0 / 0 21:27:24 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 103305216; Read time: 0; Write time: 75604 21:27:24 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 6094848; Write bytes: 328896512; Read time: 2064; Write time: 252828 21:27:24 INFO - Running post-run listener: _upload_blobber_files 21:27:24 INFO - Blob upload gear active. 21:27:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:27:24 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 21:27:24 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'] 21:27:24 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 21:27:25 INFO - (blobuploader) - INFO - Open directory for files ... 21:27:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:27:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:27:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:27:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:27:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:27:26 INFO - (blobuploader) - INFO - Done attempting. 21:27:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:27:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:27:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:27:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:27:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:27:26 INFO - (blobuploader) - INFO - Done attempting. 21:27:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 21:27:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:27:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:27:27 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 21:27:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:27:27 INFO - (blobuploader) - INFO - Done attempting. 21:27:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:27:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:27:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:27:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:27:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:27:30 INFO - (blobuploader) - INFO - Done attempting. 21:27:30 INFO - (blobuploader) - INFO - Iteration through files over. 21:27:30 INFO - Return code: 0 21:27:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:27:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:27:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01bac5be31aa451f6074e53c792277d10d075993b3f440cbfc0e7836e4bb4cf2007a9ff9731837db4cd99bb9bd4922abebe722801f9514f39ad38bdb68cfa58f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abf9a525807e0b9f3687171614f6a5bd760aa6873b403f5b14901979a1515ef13ae41e4eef1f8a9a9a22f540206a610b0b8e93ace2558695247ea0494e913292", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/decbdf1522458a08f0f6c26c0e45d86a4550977e27f65f4d9207e72782901aa877122753dd471c2d6ecb64e82de478b619ac6d88d133fdc25475b05b47bbf0ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a00aef81f81108bf9ef326e3ffe8f8a49489c69fd1753b5ec25570f5db99b6a267a63368c7c10f06a370860bef57e20eebb488d1d00201a9ce32ec69c78d6e2e"} 21:27:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:27:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:27:30 INFO - Contents: 21:27:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01bac5be31aa451f6074e53c792277d10d075993b3f440cbfc0e7836e4bb4cf2007a9ff9731837db4cd99bb9bd4922abebe722801f9514f39ad38bdb68cfa58f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abf9a525807e0b9f3687171614f6a5bd760aa6873b403f5b14901979a1515ef13ae41e4eef1f8a9a9a22f540206a610b0b8e93ace2558695247ea0494e913292", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/decbdf1522458a08f0f6c26c0e45d86a4550977e27f65f4d9207e72782901aa877122753dd471c2d6ecb64e82de478b619ac6d88d133fdc25475b05b47bbf0ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a00aef81f81108bf9ef326e3ffe8f8a49489c69fd1753b5ec25570f5db99b6a267a63368c7c10f06a370860bef57e20eebb488d1d00201a9ce32ec69c78d6e2e"} 21:27:30 INFO - Running post-run listener: copy_logs_to_upload_dir 21:27:30 INFO - Copying logs to upload dir... 21:27:30 INFO - mkdir: /builds/slave/test/build/upload/logs 21:27:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.357485 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-05-18 21:27:30.547127) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-18 21:27:30.550343) ========= 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=3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01bac5be31aa451f6074e53c792277d10d075993b3f440cbfc0e7836e4bb4cf2007a9ff9731837db4cd99bb9bd4922abebe722801f9514f39ad38bdb68cfa58f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abf9a525807e0b9f3687171614f6a5bd760aa6873b403f5b14901979a1515ef13ae41e4eef1f8a9a9a22f540206a610b0b8e93ace2558695247ea0494e913292", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/decbdf1522458a08f0f6c26c0e45d86a4550977e27f65f4d9207e72782901aa877122753dd471c2d6ecb64e82de478b619ac6d88d133fdc25475b05b47bbf0ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a00aef81f81108bf9ef326e3ffe8f8a49489c69fd1753b5ec25570f5db99b6a267a63368c7c10f06a370860bef57e20eebb488d1d00201a9ce32ec69c78d6e2e"} build_url:https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011165 build_url: 'https://queue.taskcluster.net/v1/task/caIWjHJURdmr8ocUbW1IZQ/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/01bac5be31aa451f6074e53c792277d10d075993b3f440cbfc0e7836e4bb4cf2007a9ff9731837db4cd99bb9bd4922abebe722801f9514f39ad38bdb68cfa58f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/abf9a525807e0b9f3687171614f6a5bd760aa6873b403f5b14901979a1515ef13ae41e4eef1f8a9a9a22f540206a610b0b8e93ace2558695247ea0494e913292", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/decbdf1522458a08f0f6c26c0e45d86a4550977e27f65f4d9207e72782901aa877122753dd471c2d6ecb64e82de478b619ac6d88d133fdc25475b05b47bbf0ea", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a00aef81f81108bf9ef326e3ffe8f8a49489c69fd1753b5ec25570f5db99b6a267a63368c7c10f06a370860bef57e20eebb488d1d00201a9ce32ec69c78d6e2e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-18 21:27:30.574641) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 21:27:30.574972) ========= 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=3297cc2eebb5444a7688c33f000001b5-1495164340.754143-1761994797 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004560 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-18 21:27:30.658626) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-18 21:27:30.658953) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-18 21:27:30.659253) ========= ========= Total master_lag: 0.21 =========