builder: mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s slave: talos-linux64-ix-046 starttime: 1495055314.51 results: success (0) revision: b133ec74e3d0813c0951603209fa283ef0efd8b2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-17 14:08:34.506617) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-17 14:08:34.507095) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-17 14:08:34.507397) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-17 14:08:34.525251) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 14:08:34.525533) ========= 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=652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2017-05-17 14:08:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 110M=0s 2017-05-17 14:08:35 (110 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.344506 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 14:08:34.883027) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 14:08:34.886357) ========= 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=652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016575 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 14:08:34.939705) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-17 14:08:34.940105) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b133ec74e3d0813c0951603209fa283ef0efd8b2 --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 b133ec74e3d0813c0951603209fa283ef0efd8b2 --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=652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2017-05-17 14:08:35,262 truncating revision to first 12 chars 2017-05-17 14:08:35,262 Setting DEBUG logging. 2017-05-17 14:08:35,262 attempt 1/10 2017-05-17 14:08:35,262 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b133ec74e3d0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-17 14:08:36,115 unpacking tar archive at: mozilla-central-b133ec74e3d0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.234106 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-17 14:08:36.189681) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-17 14:08:36.190004) ========= script_repo_revision: b133ec74e3d0813c0951603209fa283ef0efd8b2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-17 14:08:36.190430) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-17 14:08:36.190700) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-17 14:08:36.206558) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-05-17 14:08:36.206853) ========= /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=652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 14:08:36 INFO - MultiFileLogger online at 20170517 14:08:36 in /builds/slave/test 14:08:36 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 14:08:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:08:36 INFO - {'append_to_log': False, 14:08:36 INFO - 'base_work_dir': '/builds/slave/test', 14:08:36 INFO - 'blob_upload_branch': 'Firefox', 14:08:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:08:36 INFO - 'branch': 'Firefox', 14:08:36 INFO - 'buildbot_json_path': 'buildprops.json', 14:08:36 INFO - 'config_files': ('talos/linux_config.py',), 14:08:36 INFO - 'default_actions': ('clobber', 14:08:36 INFO - 'read-buildbot-config', 14:08:36 INFO - 'download-and-extract', 14:08:36 INFO - 'populate-webroot', 14:08:36 INFO - 'create-virtualenv', 14:08:36 INFO - 'install', 14:08:36 INFO - 'run-tests'), 14:08:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:08:36 INFO - 'download_minidump_stackwalk': True, 14:08:36 INFO - 'download_symbols': 'ondemand', 14:08:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:08:36 INFO - 'tooltool.py': '/tools/tooltool.py', 14:08:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:08:36 INFO - '/tools/misc-python/virtualenv.py')}, 14:08:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:08:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:08:36 INFO - 'gecko_profile': False, 14:08:36 INFO - 'gecko_profile_interval': 0, 14:08:36 INFO - 'installer_path': 'installer.exe', 14:08:36 INFO - 'log_level': 'info', 14:08:36 INFO - 'log_name': 'talos', 14:08:36 INFO - 'log_to_console': True, 14:08:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 14:08:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 14:08:36 INFO - 'opt_config_files': (), 14:08:36 INFO - 'pip_index': False, 14:08:36 INFO - 'suite': 'dromaeojs-e10s', 14:08:36 INFO - 'system_bits': '32', 14:08:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:08:36 INFO - 'title': 'talos-linux64-ix-046', 14:08:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:08:36 INFO - 'use_talos_json': True, 14:08:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:08:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:08:36 INFO - 'work_dir': 'build'} 14:08:36 INFO - [mozharness: 2017-05-17 21:08:36.624591Z] Running clobber step. 14:08:36 INFO - Running pre-action listener: _resource_record_pre_action 14:08:36 INFO - Running main action method: clobber 14:08:36 INFO - rmtree: /builds/slave/test/build 14:08:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:08:38 INFO - Running post-action listener: _resource_record_post_action 14:08:38 INFO - [mozharness: 2017-05-17 21:08:38.153868Z] Finished clobber step (success) 14:08:38 INFO - [mozharness: 2017-05-17 21:08:38.153966Z] Running read-buildbot-config step. 14:08:38 INFO - Running pre-action listener: _resource_record_pre_action 14:08:38 INFO - Running main action method: read_buildbot_config 14:08:38 INFO - Using buildbot properties: 14:08:38 INFO - { 14:08:38 INFO - "project": "", 14:08:38 INFO - "product": "firefox", 14:08:38 INFO - "who": "kwierso@gmail.com", 14:08:38 INFO - "installer_path": "public/build/target.tar.bz2", 14:08:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_styloseq_test-dromaeojs-e10s", 14:08:38 INFO - "repository": "https://hg.mozilla.org/mozilla-central/", 14:08:38 INFO - "buildername": "Ubuntu HW 12.04 x64 stylo-sequential mozilla-central talos dromaeojs-e10s", 14:08:38 INFO - "stage_platform": "linux64-styloseq", 14:08:38 INFO - "basedir": "/builds/slave/test", 14:08:38 INFO - "buildnumber": 7, 14:08:38 INFO - "platform": "ubuntu64_hw_styloseq", 14:08:38 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 14:08:38 INFO - "slavebuilddir": "test", 14:08:38 INFO - "taskId": "EA8f9-jnSdaFUyqzws2Oyw", 14:08:38 INFO - "branch": "mozilla-central", 14:08:38 INFO - "script_repo_revision": "production", 14:08:38 INFO - "revision": "b133ec74e3d0813c0951603209fa283ef0efd8b2", 14:08:38 INFO - "slavename": "talos-linux64-ix-046", 14:08:38 INFO - "repo_path": "mozilla-central" 14:08:38 INFO - } 14:08:38 INFO - Finding installer, test and symbols from parent task. 14:08:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EA8f9-jnSdaFUyqzws2Oyw'}, attempt #1 14:08:38 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EA8f9-jnSdaFUyqzws2Oyw'}, attempt #1 14:08:39 INFO - Task dependencies: Qczh4UEwSlOVtGe5Cl_9oA 14:08:39 INFO - retry: Calling _urlopen with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qczh4UEwSlOVtGe5Cl_9oA'}, attempt #1 14:08:39 INFO - Set installer_url: https://queue.taskcluster.net/v1/task/Qczh4UEwSlOVtGe5Cl_9oA/artifacts/public/build/target.tar.bz2 14:08:39 INFO - Set test_url: https://queue.taskcluster.net/v1/task/Qczh4UEwSlOVtGe5Cl_9oA/artifacts/public/build/test_packages.json 14:08:39 INFO - Set symbols_url: https://queue.taskcluster.net/v1/task/Qczh4UEwSlOVtGe5Cl_9oA/artifacts/public/build/target.crashreporter-symbols.zip 14:08:39 INFO - Running post-action listener: _resource_record_post_action 14:08:39 INFO - [mozharness: 2017-05-17 21:08:39.577025Z] Finished read-buildbot-config step (success) 14:08:39 INFO - [mozharness: 2017-05-17 21:08:39.577243Z] Running download-and-extract step. 14:08:39 INFO - Running pre-action listener: _resource_record_pre_action 14:08:39 INFO - Running main action method: download_and_extract 14:08:39 INFO - mkdir: /builds/slave/test/build/tests 14:08: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')]} 14:08:39 INFO - trying https://queue.taskcluster.net/v1/task/Qczh4UEwSlOVtGe5Cl_9oA/artifacts/public/build/target.test_packages.json 14:08:39 INFO - Downloading https://queue.taskcluster.net/v1/task/Qczh4UEwSlOVtGe5Cl_9oA/artifacts/public/build/target.test_packages.json to /builds/slave/test/build/target.test_packages.json 14:08:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qczh4UEwSlOVtGe5Cl_9oA/artifacts/public/build/target.test_packages.json', 'file_name': '/builds/slave/test/build/target.test_packages.json'}, attempt #1 14:08:40 INFO - Downloaded 986 bytes. 14:08:40 INFO - Reading from file /builds/slave/test/build/target.test_packages.json 14:08:40 INFO - Using the following test package requirements: 14:08:40 INFO - {u'awsy': [u'target.common.tests.zip', u'target.awsy.tests.zip'], 14:08:40 INFO - u'common': [u'target.common.tests.zip'], 14:08:40 INFO - u'cppunittest': [u'target.common.tests.zip', u'target.cppunittest.tests.zip'], 14:08:40 INFO - u'gtest': [u'target.common.tests.zip', u'target.gtest.tests.zip'], 14:08:40 INFO - u'jittest': [u'target.common.tests.zip', u'target.jsshell.zip'], 14:08:40 INFO - u'mochitest': [u'target.common.tests.zip', u'target.mochitest.tests.zip'], 14:08:40 INFO - u'mozbase': [u'target.common.tests.zip'], 14:08:40 INFO - u'reftest': [u'target.common.tests.zip', u'target.reftest.tests.zip'], 14:08:40 INFO - u'talos': [u'target.common.tests.zip', u'target.talos.tests.zip'], 14:08:40 INFO - u'web-platform': [u'target.common.tests.zip', 14:08:40 INFO - u'target.web-platform.tests.zip'], 14:08:40 INFO - u'xpcshell': [u'target.common.tests.zip', u'target.xpcshell.tests.zip']} 14:08:40 INFO - Downloading packages: [u'target.common.tests.zip'] for test suite category: common 14:08:40 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qczh4UEwSlOVtGe5Cl_9oA/artifacts/public/build/target.common.tests.zip 14:08:40 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qczh4UEwSlOVtGe5Cl_9oA/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:08:40 INFO - Fetch https://queue.taskcluster.net/v1/task/Qczh4UEwSlOVtGe5Cl_9oA/artifacts/public/build/target.common.tests.zip into memory 14:08:42 INFO - Content-Length response header: 62452400 14:08:42 INFO - Bytes received: 62452400 14:08:53 INFO - Downloading packages: [u'target.common.tests.zip', u'target.talos.tests.zip'] for test suite category: talos 14:08:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qczh4UEwSlOVtGe5Cl_9oA/artifacts/public/build/target.common.tests.zip 14:08:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qczh4UEwSlOVtGe5Cl_9oA/artifacts/public/build/target.common.tests.zip'}, attempt #1 14:08:53 INFO - Fetch https://queue.taskcluster.net/v1/task/Qczh4UEwSlOVtGe5Cl_9oA/artifacts/public/build/target.common.tests.zip into memory 14:08:54 INFO - Content-Length response header: 62452400 14:08:54 INFO - Bytes received: 62452400 14:09:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Qczh4UEwSlOVtGe5Cl_9oA/artifacts/public/build/target.talos.tests.zip 14:09:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Qczh4UEwSlOVtGe5Cl_9oA/artifacts/public/build/target.talos.tests.zip'}, attempt #1 14:09:05 INFO - Fetch https://queue.taskcluster.net/v1/task/Qczh4UEwSlOVtGe5Cl_9oA/artifacts/public/build/target.talos.tests.zip into memory 14:09:06 INFO - Content-Length response header: 14410069 14:09:06 INFO - Bytes received: 14410069 14:09: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')]} 14:09:06 INFO - trying https://queue.taskcluster.net/v1/task/Qczh4UEwSlOVtGe5Cl_9oA/artifacts/public/build/target.tar.bz2 14:09:06 INFO - Downloading https://queue.taskcluster.net/v1/task/Qczh4UEwSlOVtGe5Cl_9oA/artifacts/public/build/target.tar.bz2 to /builds/slave/test/build/target.tar.bz2 14:09:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Qczh4UEwSlOVtGe5Cl_9oA/artifacts/public/build/target.tar.bz2', 'file_name': '/builds/slave/test/build/target.tar.bz2'}, attempt #1 14:09:08 INFO - Downloaded 64990964 bytes. 14:09:08 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Qczh4UEwSlOVtGe5Cl_9oA/artifacts/public/build/target.tar.bz2 14:09:08 INFO - mkdir: /builds/slave/test/properties 14:09:08 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:09:08 INFO - Writing to file /builds/slave/test/properties/build_url 14:09:08 INFO - Contents: 14:09:08 INFO - build_url:https://queue.taskcluster.net/v1/task/Qczh4UEwSlOVtGe5Cl_9oA/artifacts/public/build/target.tar.bz2 14:09:08 INFO - Running post-action listener: _resource_record_post_action 14:09:08 INFO - Running post-action listener: set_extra_try_arguments 14:09:08 INFO - [mozharness: 2017-05-17 21:09:08.170819Z] Finished download-and-extract step (success) 14:09:08 INFO - [mozharness: 2017-05-17 21:09:08.170916Z] Running populate-webroot step. 14:09:08 INFO - Running pre-action listener: _resource_record_pre_action 14:09:08 INFO - Running main action method: populate_webroot 14:09:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:09:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:09:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:09:08 INFO - '--tppagecycles', 14:09:08 INFO - '7'], 14:09:08 INFO - 'tests': ['tsvgm']}}, 14:09:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:09:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:09:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:09:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:09:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:09:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:09:08 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:09:08 INFO - 'talos_options': ['--disable-e10s'], 14:09:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:09:08 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:09:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:09:08 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:09:08 INFO - 'talos_options': ['--disable-e10s'], 14:09:08 INFO - 'tests': ['damp', 'tps']}, 14:09:08 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:09:08 INFO - 'tests': ['damp', 'tps']}, 14:09:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:09:08 INFO - 'tests': ['dromaeo_dom']}, 14:09:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:09:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:09:08 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 14:09:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 14:09:08 INFO - 'g5-e10s': {'pagesets_name': 'tp5n.zip', 14:09:08 INFO - 'tests': ['ts_paint', 'tp5o']}, 14:09:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:09:08 INFO - 'tests': ['a11yr', 14:09:08 INFO - 'ts_paint', 14:09:08 INFO - 'tpaint', 14:09:08 INFO - 'sessionrestore', 14:09:08 INFO - 'sessionrestore_no_auto_restore', 14:09:08 INFO - 'tabpaint']}, 14:09:08 INFO - 'other-e10s': {'tests': ['a11yr', 14:09:08 INFO - 'ts_paint', 14:09:08 INFO - 'tpaint', 14:09:08 INFO - 'sessionrestore', 14:09:08 INFO - 'sessionrestore_no_auto_restore', 14:09:08 INFO - 'tabpaint']}, 14:09:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:09:08 INFO - 'ts_paint', 14:09:08 INFO - 'tpaint', 14:09:08 INFO - 'sessionrestore', 14:09:08 INFO - 'sessionrestore_no_auto_restore', 14:09:08 INFO - 'tabpaint']}, 14:09:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:09:08 INFO - 'ts_paint', 14:09:08 INFO - 'tpaint', 14:09:08 INFO - 'sessionrestore', 14:09:08 INFO - 'sessionrestore_no_auto_restore', 14:09:08 INFO - 'tabpaint']}, 14:09:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:09:08 INFO - 'tests': ['a11yr', 14:09:08 INFO - 'ts_paint', 14:09:08 INFO - 'tpaint', 14:09:08 INFO - 'sessionrestore', 14:09:08 INFO - 'sessionrestore_no_auto_restore', 14:09:08 INFO - 'tabpaint']}, 14:09:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:09:08 INFO - 'tests': ['a11yr', 14:09:08 INFO - 'ts_paint', 14:09:08 INFO - 'tpaint', 14:09:08 INFO - 'sessionrestore', 14:09:08 INFO - 'sessionrestore_no_auto_restore', 14:09:08 INFO - 'tabpaint']}, 14:09:08 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 14:09:08 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 14:09:08 INFO - 'bloom_basic_ref']}, 14:09:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:09:08 INFO - 'tests': ['tsvgx', 14:09:08 INFO - 'tsvgr_opacity', 14:09:08 INFO - 'tart', 14:09:08 INFO - 'tscrollx', 14:09:08 INFO - 'cart', 14:09:08 INFO - 'tsvg_static']}, 14:09:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:09:08 INFO - 'tsvgr_opacity', 14:09:08 INFO - 'tart', 14:09:08 INFO - 'tscrollx', 14:09:08 INFO - 'cart', 14:09:08 INFO - 'tsvg_static']}, 14:09:08 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:09:08 INFO - 'talos_options': ['--disable-e10s'], 14:09:08 INFO - 'tests': ['tp5o']}, 14:09:08 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:09:08 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:09:08 INFO - 'talos_options': ['--disable-e10s', 14:09:08 INFO - '--xperf_path', 14:09:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:09:08 INFO - 'tests': ['tp5n']}, 14:09:08 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:09:08 INFO - 'talos_options': ['--xperf_path', 14:09:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:09:08 INFO - 'tests': ['tp5n']}}, 14:09:08 INFO - 'talos.zip': {'path': '', 14:09:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:09:08 INFO - Running post-action listener: _resource_record_post_action 14:09:08 INFO - [mozharness: 2017-05-17 21:09:08.184868Z] Finished populate-webroot step (success) 14:09:08 INFO - [mozharness: 2017-05-17 21:09:08.184957Z] Running create-virtualenv step. 14:09:08 INFO - Running pre-action listener: _resource_record_pre_action 14:09:08 INFO - Running main action method: create_virtualenv 14:09:08 INFO - Creating virtualenv /builds/slave/test/build/venv 14:09:08 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:09:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:09:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:09:08 INFO - Using real prefix '/usr' 14:09:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:09:08 INFO - Installing distribute.............................................................................................................................................................................................done. 14:09:10 INFO - Installing pip.................done. 14:09:10 INFO - Return code: 0 14:09:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:09:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:09:10 INFO - Reading from file tmpfile_stdout 14:09:10 INFO - Output received: 14:09:10 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:09:10 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:09: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')]} 14:09:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09: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')]} 14:09:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a877a0>, '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 0x1a886a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a88b30>, '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': '652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058', '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 14:09: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', 'pip>=1.5'] in /builds/slave/test/build 14:09: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 pip>=1.5 14:09:10 INFO - Using env: {'DISPLAY': ':0', 14:09:10 INFO - 'HOME': '/home/cltbld', 14:09:10 INFO - 'LANG': 'en_US.UTF-8', 14:09:10 INFO - 'LANGUAGE': 'en_US:en', 14:09:10 INFO - 'LOGNAME': 'cltbld', 14:09:10 INFO - 'MAIL': '/var/mail/cltbld', 14:09:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:10 INFO - 'MOZ_NO_REMOTE': '1', 14:09:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:10 INFO - 'NO_EM_RESTART': '1', 14:09:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:10 INFO - 'PWD': '/builds/slave/test', 14:09:10 INFO - 'SHELL': '/bin/bash', 14:09:10 INFO - 'SHLVL': '1', 14:09:10 INFO - 'TERM': 'linux', 14:09:10 INFO - 'TMOUT': '86400', 14:09:10 INFO - 'USER': 'cltbld', 14:09:10 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058', 14:09:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:10 INFO - '_': '/tools/buildbot/bin/python'} 14:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:11 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:09:11 INFO - Cleaning up... 14:09:11 INFO - Return code: 0 14:09:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:09:11 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')]} 14:09:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:11 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')]} 14:09:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x17171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a877a0>, '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 0x1a886a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a88b30>, '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': '652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058', '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 14:09:11 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 14:09:11 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 14:09:11 INFO - Using env: {'DISPLAY': ':0', 14:09:11 INFO - 'HOME': '/home/cltbld', 14:09:11 INFO - 'LANG': 'en_US.UTF-8', 14:09:11 INFO - 'LANGUAGE': 'en_US:en', 14:09:11 INFO - 'LOGNAME': 'cltbld', 14:09:11 INFO - 'MAIL': '/var/mail/cltbld', 14:09:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:11 INFO - 'MOZ_NO_REMOTE': '1', 14:09:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:11 INFO - 'NO_EM_RESTART': '1', 14:09:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:11 INFO - 'PWD': '/builds/slave/test', 14:09:11 INFO - 'SHELL': '/bin/bash', 14:09:11 INFO - 'SHLVL': '1', 14:09:11 INFO - 'TERM': 'linux', 14:09:11 INFO - 'TMOUT': '86400', 14:09:11 INFO - 'USER': 'cltbld', 14:09:11 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058', 14:09:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:11 INFO - '_': '/tools/buildbot/bin/python'} 14:09:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:11 INFO - Downloading/unpacking psutil>=3.1.1 14:09: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 14:09: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 14:09: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 14:09: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 14:09:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:09:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:09:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:09:12 INFO - Installing collected packages: psutil 14:09:12 INFO - Running setup.py install for psutil 14:09:12 INFO - building 'psutil._psutil_linux' extension 14:09:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 14:09:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 14:09:12 INFO - building 'psutil._psutil_posix' extension 14:09:12 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 14:09:12 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 14:09:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:09:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:09:13 INFO - Successfully installed psutil 14:09:13 INFO - Cleaning up... 14:09:13 INFO - Return code: 0 14:09:13 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:09:13 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')]} 14:09:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:13 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')]} 14:09:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:13 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x17171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a877a0>, '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 0x1a886a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a88b30>, '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': '652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058', '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 14:09:13 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 14:09:13 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 14:09:13 INFO - Using env: {'DISPLAY': ':0', 14:09:13 INFO - 'HOME': '/home/cltbld', 14:09:13 INFO - 'LANG': 'en_US.UTF-8', 14:09:13 INFO - 'LANGUAGE': 'en_US:en', 14:09:13 INFO - 'LOGNAME': 'cltbld', 14:09:13 INFO - 'MAIL': '/var/mail/cltbld', 14:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:13 INFO - 'MOZ_NO_REMOTE': '1', 14:09:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:13 INFO - 'NO_EM_RESTART': '1', 14:09:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:13 INFO - 'PWD': '/builds/slave/test', 14:09:13 INFO - 'SHELL': '/bin/bash', 14:09:13 INFO - 'SHLVL': '1', 14:09:13 INFO - 'TERM': 'linux', 14:09:13 INFO - 'TMOUT': '86400', 14:09:13 INFO - 'USER': 'cltbld', 14:09:13 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058', 14:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:13 INFO - '_': '/tools/buildbot/bin/python'} 14:09:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:13 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:09: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 14:09: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 14:09: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 14:09: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 14:09:14 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:09:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:09:14 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:09:14 INFO - Installing collected packages: mozsystemmonitor 14:09:14 INFO - Running setup.py install for mozsystemmonitor 14:09:14 INFO - Successfully installed mozsystemmonitor 14:09:14 INFO - Cleaning up... 14:09:14 INFO - Return code: 0 14:09:14 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:09:14 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')]} 14:09:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:14 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')]} 14:09:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x17171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a877a0>, '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 0x1a886a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a88b30>, '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': '652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058', '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 14:09:14 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 14:09:14 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 14:09:14 INFO - Using env: {'DISPLAY': ':0', 14:09:14 INFO - 'HOME': '/home/cltbld', 14:09:14 INFO - 'LANG': 'en_US.UTF-8', 14:09:14 INFO - 'LANGUAGE': 'en_US:en', 14:09:14 INFO - 'LOGNAME': 'cltbld', 14:09:14 INFO - 'MAIL': '/var/mail/cltbld', 14:09:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:14 INFO - 'MOZ_NO_REMOTE': '1', 14:09:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:14 INFO - 'NO_EM_RESTART': '1', 14:09:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:14 INFO - 'PWD': '/builds/slave/test', 14:09:14 INFO - 'SHELL': '/bin/bash', 14:09:14 INFO - 'SHLVL': '1', 14:09:14 INFO - 'TERM': 'linux', 14:09:14 INFO - 'TMOUT': '86400', 14:09:14 INFO - 'USER': 'cltbld', 14:09:14 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058', 14:09:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:14 INFO - '_': '/tools/buildbot/bin/python'} 14:09:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:14 INFO - Downloading/unpacking jsonschema==2.5.1 14:09: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 14:09: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 14:09: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 14:09: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 14:09:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:09:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:16 INFO - Downloading functools32-3.2.3-2.tar.gz 14:09:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:09:16 INFO - warning: no files found matching '*.txt' 14:09:16 INFO - no previously-included directories found matching 'build' 14:09:16 INFO - no previously-included directories found matching 'dist' 14:09:16 INFO - no previously-included directories found matching '.git*' 14:09:16 INFO - Installing collected packages: jsonschema, functools32 14:09:16 INFO - Running setup.py install for functools32 14:09:16 INFO - warning: no files found matching '*.txt' 14:09:16 INFO - no previously-included directories found matching 'build' 14:09:16 INFO - no previously-included directories found matching 'dist' 14:09:16 INFO - no previously-included directories found matching '.git*' 14:09:16 INFO - Successfully installed jsonschema functools32 14:09:16 INFO - Cleaning up... 14:09:16 INFO - Return code: 0 14:09:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:09:16 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')]} 14:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:16 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')]} 14:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x17171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a877a0>, '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 0x1a886a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a88b30>, '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': '652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058', '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 14:09:16 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 14:09:16 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 14:09:16 INFO - Using env: {'DISPLAY': ':0', 14:09:16 INFO - 'HOME': '/home/cltbld', 14:09:16 INFO - 'LANG': 'en_US.UTF-8', 14:09:16 INFO - 'LANGUAGE': 'en_US:en', 14:09:16 INFO - 'LOGNAME': 'cltbld', 14:09:16 INFO - 'MAIL': '/var/mail/cltbld', 14:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:16 INFO - 'MOZ_NO_REMOTE': '1', 14:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:16 INFO - 'NO_EM_RESTART': '1', 14:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:16 INFO - 'PWD': '/builds/slave/test', 14:09:16 INFO - 'SHELL': '/bin/bash', 14:09:16 INFO - 'SHLVL': '1', 14:09:16 INFO - 'TERM': 'linux', 14:09:16 INFO - 'TMOUT': '86400', 14:09:16 INFO - 'USER': 'cltbld', 14:09:16 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058', 14:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:16 INFO - '_': '/tools/buildbot/bin/python'} 14:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:09:16 INFO - Cleaning up... 14:09:16 INFO - Return code: 0 14:09:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:09:16 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')]} 14:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:16 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')]} 14:09:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x17171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a877a0>, '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 0x1a886a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a88b30>, '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': '652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058', '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 14:09:16 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 14:09:16 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 14:09:16 INFO - Using env: {'DISPLAY': ':0', 14:09:16 INFO - 'HOME': '/home/cltbld', 14:09:16 INFO - 'LANG': 'en_US.UTF-8', 14:09:16 INFO - 'LANGUAGE': 'en_US:en', 14:09:16 INFO - 'LOGNAME': 'cltbld', 14:09:16 INFO - 'MAIL': '/var/mail/cltbld', 14:09:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:16 INFO - 'MOZ_NO_REMOTE': '1', 14:09:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:16 INFO - 'NO_EM_RESTART': '1', 14:09:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:16 INFO - 'PWD': '/builds/slave/test', 14:09:16 INFO - 'SHELL': '/bin/bash', 14:09:16 INFO - 'SHLVL': '1', 14:09:16 INFO - 'TERM': 'linux', 14:09:16 INFO - 'TMOUT': '86400', 14:09:16 INFO - 'USER': 'cltbld', 14:09:16 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058', 14:09:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:16 INFO - '_': '/tools/buildbot/bin/python'} 14:09:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:16 INFO - Downloading/unpacking blobuploader==1.2.4 14:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:17 INFO - Downloading blobuploader-1.2.4.tar.gz 14:09:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:09:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:09:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:18 INFO - Downloading docopt-0.6.1.tar.gz 14:09:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:09:18 INFO - Installing collected packages: blobuploader, requests, docopt 14:09:18 INFO - Running setup.py install for blobuploader 14:09:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:09:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:09:18 INFO - Running setup.py install for requests 14:09:18 INFO - Running setup.py install for docopt 14:09:18 INFO - Successfully installed blobuploader requests docopt 14:09:18 INFO - Cleaning up... 14:09:19 INFO - Return code: 0 14:09:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09:19 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')]} 14:09:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:19 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')]} 14:09:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x17171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a877a0>, '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 0x1a886a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a88b30>, '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': '652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058', '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 14:09:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:09:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:09:19 INFO - Using env: {'DISPLAY': ':0', 14:09:19 INFO - 'HOME': '/home/cltbld', 14:09:19 INFO - 'LANG': 'en_US.UTF-8', 14:09:19 INFO - 'LANGUAGE': 'en_US:en', 14:09:19 INFO - 'LOGNAME': 'cltbld', 14:09:19 INFO - 'MAIL': '/var/mail/cltbld', 14:09:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:19 INFO - 'MOZ_NO_REMOTE': '1', 14:09:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:19 INFO - 'NO_EM_RESTART': '1', 14:09:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:19 INFO - 'PWD': '/builds/slave/test', 14:09:19 INFO - 'SHELL': '/bin/bash', 14:09:19 INFO - 'SHLVL': '1', 14:09:19 INFO - 'TERM': 'linux', 14:09:19 INFO - 'TMOUT': '86400', 14:09:19 INFO - 'USER': 'cltbld', 14:09:19 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058', 14:09:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:19 INFO - '_': '/tools/buildbot/bin/python'} 14:09:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:09:19 INFO - Running setup.py (path:/tmp/pip-zNU4s_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:09:19 INFO - Running setup.py (path:/tmp/pip-2onuA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:09:19 INFO - Running setup.py (path:/tmp/pip-i9G61a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:09:19 INFO - Running setup.py (path:/tmp/pip-vFksE9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:09:19 INFO - Running setup.py (path:/tmp/pip-fn2NDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:09:19 INFO - Running setup.py (path:/tmp/pip-i2RzLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:09:19 INFO - Running setup.py (path:/tmp/pip-df1ku2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:09:19 INFO - Running setup.py (path:/tmp/pip-8p6Ney-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:09:19 INFO - Running setup.py (path:/tmp/pip-vhrcX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:09:19 INFO - Running setup.py (path:/tmp/pip-3mZBBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:09:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:09:19 INFO - Running setup.py (path:/tmp/pip-ujFWxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:09:20 INFO - Running setup.py (path:/tmp/pip-_Opuzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:09:20 INFO - Running setup.py (path:/tmp/pip-Fsq88H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:09:20 INFO - Running setup.py (path:/tmp/pip-0lYPBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:20 INFO - Running setup.py (path:/tmp/pip-gFbu8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:09:20 INFO - Running setup.py (path:/tmp/pip-hv6tqp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:09:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:09:20 INFO - Running setup.py (path:/tmp/pip-xS514M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:09:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:09:20 INFO - Running setup.py install for manifestparser 14:09:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:09:20 INFO - Running setup.py install for mozcrash 14:09:20 INFO - Running setup.py install for mozdebug 14:09:20 INFO - Running setup.py install for mozdevice 14:09:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:09:20 INFO - Running setup.py install for mozfile 14:09:20 INFO - Running setup.py install for mozhttpd 14:09:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:09:21 INFO - Running setup.py install for mozinfo 14:09:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:09:21 INFO - Running setup.py install for mozInstall 14:09:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:09:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:09:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:09:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:09:21 INFO - Running setup.py install for mozleak 14:09:21 INFO - Running setup.py install for mozlog 14:09:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:09:21 INFO - Running setup.py install for moznetwork 14:09:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:09:21 INFO - Running setup.py install for mozprocess 14:09:21 INFO - Running setup.py install for mozprofile 14:09:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:09:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:09:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:09:21 INFO - Running setup.py install for mozrunner 14:09:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:09:21 INFO - Running setup.py install for mozscreenshot 14:09:22 INFO - Running setup.py install for moztest 14:09:22 INFO - Running setup.py install for mozversion 14:09:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:09:22 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:09:22 INFO - Cleaning up... 14:09:22 INFO - Return code: 0 14:09:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09:22 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')]} 14:09:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:22 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')]} 14:09:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x17171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a877a0>, '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 0x1a886a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a88b30>, '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': '652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058', '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 14:09:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:09:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:09:22 INFO - Using env: {'DISPLAY': ':0', 14:09:22 INFO - 'HOME': '/home/cltbld', 14:09:22 INFO - 'LANG': 'en_US.UTF-8', 14:09:22 INFO - 'LANGUAGE': 'en_US:en', 14:09:22 INFO - 'LOGNAME': 'cltbld', 14:09:22 INFO - 'MAIL': '/var/mail/cltbld', 14:09:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:22 INFO - 'MOZ_NO_REMOTE': '1', 14:09:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:22 INFO - 'NO_EM_RESTART': '1', 14:09:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:22 INFO - 'PWD': '/builds/slave/test', 14:09:22 INFO - 'SHELL': '/bin/bash', 14:09:22 INFO - 'SHLVL': '1', 14:09:22 INFO - 'TERM': 'linux', 14:09:22 INFO - 'TMOUT': '86400', 14:09:22 INFO - 'USER': 'cltbld', 14:09:22 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058', 14:09:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:22 INFO - '_': '/tools/buildbot/bin/python'} 14:09:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:09:22 INFO - Running setup.py (path:/tmp/pip-gPdYYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:09:22 INFO - Running setup.py (path:/tmp/pip-JfjwJX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:09:22 INFO - Running setup.py (path:/tmp/pip-7prEqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:09:22 INFO - Running setup.py (path:/tmp/pip-h1_Cyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:09:22 INFO - Running setup.py (path:/tmp/pip-Sialt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:09:22 INFO - Running setup.py (path:/tmp/pip-tMXAfC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:09:22 INFO - Running setup.py (path:/tmp/pip-74Eut4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:09:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:09:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:09:22 INFO - Running setup.py (path:/tmp/pip-KWPic6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:09:23 INFO - Running setup.py (path:/tmp/pip-OmvZRq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:09:23 INFO - Running setup.py (path:/tmp/pip-fHgUpU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:09:23 INFO - Running setup.py (path:/tmp/pip-JSEi3d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:09:23 INFO - Running setup.py (path:/tmp/pip-RWtiwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:09:23 INFO - Running setup.py (path:/tmp/pip-YuNZQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:09:23 INFO - Running setup.py (path:/tmp/pip-H7knb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:23 INFO - Running setup.py (path:/tmp/pip-1nRywU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:09:23 INFO - Running setup.py (path:/tmp/pip-Mgs1mZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:09:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:09:23 INFO - Running setup.py (path:/tmp/pip-66l53G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:09:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:09:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:09:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:09:24 INFO - Downloading blessings-1.6.tar.gz 14:09:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:09:24 INFO - Installing collected packages: blessings 14:09:24 INFO - Running setup.py install for blessings 14:09:24 INFO - Successfully installed blessings 14:09:24 INFO - Cleaning up... 14:09:25 INFO - Return code: 0 14:09:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:09:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:09:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:09:25 INFO - Reading from file tmpfile_stdout 14:09:25 INFO - Current package versions: 14:09:25 INFO - argparse == 1.2.1 14:09:25 INFO - blessings == 1.6 14:09:25 INFO - blobuploader == 1.2.4 14:09:25 INFO - docopt == 0.6.1 14:09:25 INFO - functools32 == 3.2.3-2 14:09:25 INFO - jsonschema == 2.5.1 14:09:25 INFO - manifestparser == 1.1 14:09:25 INFO - mozInstall == 1.12 14:09:25 INFO - mozcrash == 1.0 14:09:25 INFO - mozdebug == 0.1 14:09:25 INFO - mozdevice == 0.50 14:09:25 INFO - mozfile == 1.2 14:09:25 INFO - mozhttpd == 0.7 14:09:25 INFO - mozinfo == 0.9 14:09:25 INFO - mozleak == 0.1 14:09:25 INFO - mozlog == 3.4 14:09:25 INFO - moznetwork == 0.27 14:09:25 INFO - mozprocess == 0.25 14:09:25 INFO - mozprofile == 0.28 14:09:25 INFO - mozrunner == 6.13 14:09:25 INFO - mozscreenshot == 0.1 14:09:25 INFO - mozsystemmonitor == 0.3 14:09:25 INFO - moztest == 0.8 14:09:25 INFO - mozversion == 1.4 14:09:25 INFO - psutil == 3.1.1 14:09:25 INFO - requests == 1.2.3 14:09:25 INFO - wsgiref == 0.1.2 14:09:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:09:25 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')]} 14:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:25 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')]} 14:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x17171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a877a0>, '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 0x1a886a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a88b30>, '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': '652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058', '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 14:09:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:09:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:09:25 INFO - Using env: {'DISPLAY': ':0', 14:09:25 INFO - 'HOME': '/home/cltbld', 14:09:25 INFO - 'LANG': 'en_US.UTF-8', 14:09:25 INFO - 'LANGUAGE': 'en_US:en', 14:09:25 INFO - 'LOGNAME': 'cltbld', 14:09:25 INFO - 'MAIL': '/var/mail/cltbld', 14:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:25 INFO - 'MOZ_NO_REMOTE': '1', 14:09:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:25 INFO - 'NO_EM_RESTART': '1', 14:09:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:25 INFO - 'PWD': '/builds/slave/test', 14:09:25 INFO - 'SHELL': '/bin/bash', 14:09:25 INFO - 'SHLVL': '1', 14:09:25 INFO - 'TERM': 'linux', 14:09:25 INFO - 'TMOUT': '86400', 14:09:25 INFO - 'USER': 'cltbld', 14:09:25 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058', 14:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:25 INFO - '_': '/tools/buildbot/bin/python'} 14:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:09:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:09:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:09:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:09:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:09:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:09:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:09:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:09:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:09:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:09:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:09:25 INFO - Cleaning up... 14:09:25 INFO - Return code: 0 14:09:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:09:25 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')]} 14:09:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:09:25 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')]} 14:09:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:09:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org/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 0x17171f0>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x18e4a80>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a8a5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a877a0>, '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 0x1a886a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a88b30>, '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': '652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058', '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 14:09:25 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 14:09:25 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 14:09:25 INFO - Using env: {'DISPLAY': ':0', 14:09:25 INFO - 'HOME': '/home/cltbld', 14:09:25 INFO - 'LANG': 'en_US.UTF-8', 14:09:25 INFO - 'LANGUAGE': 'en_US:en', 14:09:25 INFO - 'LOGNAME': 'cltbld', 14:09:25 INFO - 'MAIL': '/var/mail/cltbld', 14:09:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:25 INFO - 'MOZ_NO_REMOTE': '1', 14:09:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:25 INFO - 'NO_EM_RESTART': '1', 14:09:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:25 INFO - 'PWD': '/builds/slave/test', 14:09:25 INFO - 'SHELL': '/bin/bash', 14:09:25 INFO - 'SHLVL': '1', 14:09:25 INFO - 'TERM': 'linux', 14:09:25 INFO - 'TMOUT': '86400', 14:09:25 INFO - 'USER': 'cltbld', 14:09:25 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058', 14:09:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:25 INFO - '_': '/tools/buildbot/bin/python'} 14:09:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:09:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:09:25 INFO - Cleaning up... 14:09:25 INFO - Return code: 0 14:09:25 INFO - Running post-action listener: _resource_record_post_action 14:09:25 INFO - Running post-action listener: _start_resource_monitoring 14:09:25 INFO - Starting resource monitoring. 14:09:25 INFO - [mozharness: 2017-05-17 21:09:25.740054Z] Finished create-virtualenv step (success) 14:09:25 INFO - [mozharness: 2017-05-17 21:09:25.740655Z] Running install step. 14:09:25 INFO - Running pre-action listener: _resource_record_pre_action 14:09:25 INFO - Running main action method: install 14:09:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:09:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:09:25 INFO - Reading from file tmpfile_stdout 14:09:25 INFO - Detecting whether we're running mozinstall >=1.0... 14:09:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:09:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:09:26 INFO - Reading from file tmpfile_stdout 14:09:26 INFO - Output received: 14:09:26 INFO - Usage: mozinstall [options] installer 14:09:26 INFO - Options: 14:09:26 INFO - -h, --help show this help message and exit 14:09:26 INFO - -d DEST, --destination=DEST 14:09:26 INFO - Directory to install application into. [default: 14:09:26 INFO - "/builds/slave/test"] 14:09:26 INFO - --app=APP Application being installed. [default: firefox] 14:09:26 INFO - mkdir: /builds/slave/test/build/application 14:09:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/target.tar.bz2', '--destination', '/builds/slave/test/build/application'] 14:09:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/target.tar.bz2 --destination /builds/slave/test/build/application 14:09:42 INFO - Reading from file tmpfile_stdout 14:09:42 INFO - Output received: 14:09:42 INFO - /builds/slave/test/build/application/firefox/firefox 14:09:42 INFO - Running post-action listener: _resource_record_post_action 14:09:42 INFO - [mozharness: 2017-05-17 21:09:42.370506Z] Finished install step (success) 14:09:42 INFO - [mozharness: 2017-05-17 21:09:42.370778Z] Running run-tests step. 14:09:42 INFO - Running pre-action listener: _resource_record_pre_action 14:09:42 INFO - Running main action method: run_tests 14:09:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:09:42 INFO - Python 2.7.3 14:09:42 INFO - Return code: 0 14:09:42 INFO - grabbing minidump binary from tooltool 14:09:42 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')]} 14:09:42 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 0x1a877a0>, '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 0x1a886a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a88b30>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:09:42 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 14:09:42 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 14:09:42 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 14:09:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:09:42 INFO - Return code: 0 14:09:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 14:09:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:09:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:09:42 INFO - ENV: RUST_BACKTRACE is now 1 14:09:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 14:09:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:09:42 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/Qczh4UEwSlOVtGe5Cl_9oA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 14:09:42 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/Qczh4UEwSlOVtGe5Cl_9oA/artifacts/public/build/target.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 14:09:42 INFO - Using env: {'DISPLAY': ':0', 14:09:42 INFO - 'HOME': '/home/cltbld', 14:09:42 INFO - 'LANG': 'en_US.UTF-8', 14:09:42 INFO - 'LANGUAGE': 'en_US:en', 14:09:42 INFO - 'LOGNAME': 'cltbld', 14:09:42 INFO - 'MAIL': '/var/mail/cltbld', 14:09:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:09:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 14:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:09:42 INFO - 'MOZ_NO_REMOTE': '1', 14:09:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 14:09:42 INFO - 'NO_EM_RESTART': '1', 14:09:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 14:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:09:42 INFO - 'PWD': '/builds/slave/test', 14:09:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:09:42 INFO - 'RUST_BACKTRACE': '1', 14:09:42 INFO - 'SHELL': '/bin/bash', 14:09:42 INFO - 'SHLVL': '1', 14:09:42 INFO - 'TERM': 'linux', 14:09:42 INFO - 'TMOUT': '86400', 14:09:42 INFO - 'USER': 'cltbld', 14:09:42 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058', 14:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:09:42 INFO - '_': '/tools/buildbot/bin/python'} 14:09:42 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/Qczh4UEwSlOVtGe5Cl_9oA/artifacts/public/build/target.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 14:09:42 INFO - mozversion application_buildid: 20170517203210 14:09:42 INFO - mozversion application_changeset: b133ec74e3d0813c0951603209fa283ef0efd8b2 14:09:42 INFO - mozversion application_display_name: Nightly 14:09:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:09:42 INFO - mozversion application_name: Firefox 14:09:42 INFO - mozversion application_remotingname: firefox 14:09:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:09:42 INFO - mozversion application_vendor: Mozilla 14:09:42 INFO - mozversion application_version: 55.0a1 14:09:42 INFO - mozversion platform_buildid: 20170517203210 14:09:42 INFO - mozversion platform_changeset: b133ec74e3d0813c0951603209fa283ef0efd8b2 14:09:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:09:42 INFO - mozversion platform_version: 55.0a1 14:09:42 INFO - using testdate: 1495055382 14:09:42 INFO - actual date: 1495055382 14:09:42 INFO - starting webserver on 'localhost:53588' 14:09:42 INFO - SUITE-START | Running 2 tests 14:09:42 INFO - TEST-START | dromaeo_css 14:09:42 INFO - operating with platform_type : linux_ 14:09:42 INFO - Initialising browser for dromaeo_css test... 14:09:42 INFO - TEST-INFO | started process 14960 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIiUjqi/profile http://localhost:53588/getInfo.html) 14:09:43 INFO - PID 14960 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2939: String.localeCompare is deprecated; use String.prototype.localeCompare instead 14:09:46 INFO - PID 14960 | __metrics Screen width/height:1600/1200 14:09:46 INFO - PID 14960 | colorDepth:24 14:09:46 INFO - PID 14960 | Browser inner width/height: 1024/695 14:09:46 INFO - PID 14960 | __metrics 14:09:48 INFO - TEST-INFO | 14960: exit 0 14:09:48 INFO - Browser initialized. 14:09:48 INFO - Running cycle 1/1 for dromaeo_css test... 14:09:48 INFO - TEST-INFO | started process 15150 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpIiUjqi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:10:00 INFO - PID 15150 | RSS: Main: 167018496 14:10:00 INFO - PID 15150 | 14:13:05 INFO - PID 15150 | Cycle 1(1): loaded http://localhost:53588/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53588/tests/dromaeo/cssquery-ext.html) 14:13:07 INFO - PID 15150 | RSS: Main: 172093440 14:13:07 INFO - PID 15150 | 14:13:58 INFO - PID 15150 | Sandbox: Unexpected EOF, op 2 flags 00 path /etc/fonts/conf.d/89-tlwg-garuda-synthetic.conf 14:16:09 INFO - PID 15150 | Cycle 1(1): loaded http://localhost:53588/tests/dromaeo/cssquery-ext.html (next: http://localhost:53588/tests/dromaeo/cssquery-jquery.html) 14:16:10 INFO - PID 15150 | RSS: Main: 171286528 14:16:10 INFO - PID 15150 | 14:19:12 INFO - PID 15150 | Cycle 1(1): loaded http://localhost:53588/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53588/tests/dromaeo/cssquery-mootools.html) 14:19:13 INFO - PID 15150 | RSS: Main: 172625920 14:19:13 INFO - PID 15150 | 14:22:14 INFO - PID 15150 | Cycle 1(1): loaded http://localhost:53588/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53588/tests/dromaeo/cssquery-prototype.html) 14:22:15 INFO - PID 15150 | RSS: Main: 171126784 14:22:15 INFO - PID 15150 | 14:25:18 INFO - PID 15150 | Cycle 1(1): loaded http://localhost:53588/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53588/tests/dromaeo/cssquery-yui.html) 14:25:19 INFO - PID 15150 | RSS: Main: 171651072 14:25:19 INFO - PID 15150 | 14:28:21 INFO - PID 15150 | Cycle 1(1): loaded http://localhost:53588/tests/dromaeo/cssquery-yui.html (next: http://localhost:53588/tests/dromaeo/cssquery-dojo.html) 14:28:21 INFO - PID 15150 | RSS: Main: 177389568 14:28:21 INFO - PID 15150 | 14:28:21 INFO - PID 15150 | __start_tp_report 14:28:21 INFO - PID 15150 | _x_x_mozilla_page_load 14:28:21 INFO - PID 15150 | _x_x_mozilla_page_load_details 14:28:21 INFO - PID 15150 | |i|pagename|runs| 14:28:21 INFO - PID 15150 | |0;dojo.html;2689.435218604093;2705.5400581901076;2724.6866610339803;2733.152722655976;2737.2746222251108;5223.764930578123;5226.895462090756;5239.8428047158595;5266.052110620097;5313.256144139818;5308.893822123555;5320.441353657859;5328.20076988451;5394.487523685253;5406.810761623344;4714.387129673138;4724.952750472503;4731.597814185799;4758.119747846642;4803.375561177042;4665.300204969248;4760.33355330254;4787.042591481701;4798.23228283473;4853.077915196119;4657.115148121846;4716.599089077433;4731.361266229083;4731.787069581877;4778.617710583145;4727.76361181943;4736.123817093849;4776.211925032366;4798.2802579613335;4808.759562021885;4645.535446455361;4681.555252251031;4688.507706690816;4691.577758001797;4747.976260118712;5211.42674305826;5230.555402790767;5304.230886521472;5309.973450132763;5326.7070311132875;5691.9146212806845;5746.396628354005;5799.594028417971;5821.88356232873;5834;5756.309242890838;5767.480926716616;5774.133879918046;5795.594308398414;5797.043487824504;5324.520793128637;5325.174597937287;5333.280007198979;5348.625596208228;5390.649607775482;5842.503387212049;5929.347771745104;5932.139839723216;5946.851328716817;5950.047992321208;5567.081431563746;5574.9721251393485;5582.162675598612;5584.329880414376;5587.189857470726;5665.036943719578;5666.121751128581;5686.230752064321;5710.314762228476;5789.247397838254;5736.024875771129;5744.51171650406;5749.281339832521;5763.308402991668;5789.015867302569;5726.942730572724;5743.195952566644;5744.396838331915;5749.655020698771;5762.567807414461;4812.374391329175;4817.012512434942;4878.585320247747;4905.043516514245;4908.312836202935;4213.241616508996;4215.683823713233;4262.6376757975295;4276.550962148992;4286.057067445157;4844.903101938012;4844.975775121173;4866.756662166948;4876.609871210295;4877.244027175793;5708.971455142698;5715.428457154251;5793.420657934173;5802.796902108406;5826.359100498942;4770.998090400985;4842.951570484321;4843.4430040545085;4860.076585448754;4882.633802464829;5185.22221666753;5210.505002024802;5214.270002199695;5215.374155101412;5232.633715639945;5332.493413125747;5334.626576139788;5335.253064570886;5335.679859208305;5339.9466005341;5705.885882282248;5802.622829516068;5814.883702326015;5815.2149459822385;5865.677387743715;5192.792288308426;5261;5296.152615581488;5297.549708274686;5325.786968521371;5632.239647647515;5677.914831277617;5703.401142880104;5729.598928075162;5770.884582308414;5673.659580425187;5762.654240745569;5790.5946583740415;5803.7388317524965;5804.332501762183;5458.399576046711;5578.86052848682;5579.860503487445;5586.77652893896;5592.860178495407;5573.832785016456;5585.273914391266;5594.804181853616;5596.216529685766;5606.495415412633;5457.836264912059;5520.613557050968;5532.778688852401;5537.446255374431;5540.7783688652;5602.1036634138345;5608.2148499209325;5619.550435965195;5629.971850140723;5642.774289028393;5351.491608297206;5455.863603409946;5467.480589344006;5474.2062400950845;5477.260569823023 14:28:21 INFO - PID 15150 | |1;ext.html;740.8814589665653;759.4380158682575;1136.727185475486;1181.0433548825458;1187.8277649740794;33758.66241337586;34559.48160777587;34624.480632790466;34652.65347346526;34660.82669586648;32170.195745106324;32385.352292954125;32489.83755081221;32497.187570310754;32506.837465812696;6734.8653026939555;6887.311268873098;6910.101686780711;6911.136107986502;6920.584764914096;6906.930930690704;7031.50779445439;7041.507094503361;7051.400630946376;7051.717931282768;7029.82425439363;7051.541649792773;7066.434685225169;7071.151461824588;7086.362227399533;6976.476764242702;6983.546069505466;7013.824654383656;7044.471664625174;7058.435325173974;6867.3476019778045;6917.619530925847;6921.688524016431;6922.930770692279;6926.861462770767;30704;31294.21764455884;31295;31402.528962065586;31420.528692069638;2954.9409011819857;2985.447692176954;2991.0578167877047;2992.132281638322;2995.266159790843;24138.155164569154;24373.146939857197;24504.264872053867;24505.14232001889;24591.262262132164;3123.1411361875666;3135.404273188087;3152.0701393089093;3159.57345758322;3179.1257404213793;136837.3158134213;137745.311273444;138529;139416.99999999898;149626;38416.23167536689;38420.42369364462;38534.80732596319;38535.14648535124;38550.42174367387;39923.60076399257;40393.39409908854;43217.783911080245;43965.78017109894;43980.78009609995;13349.532766353132;13356.131851429625;13361.665958350924;13408.396622152026;13494.595162145151;10702.625408110835;10803.351798892092;10815.297005694762;10834.187435942336;10872.510737016853;12601.621951341474;12675.429605667767;12784.360781960864;12788.616341509769;12894.613161605166;5446.346438427414;5497.471163264863;5497.642653227527;5499.312585926759;5532.3914369419335;874.7419511244071;876.9824603507894;917.0050495212769;927.3786563002805;935.0976307862945;19456.707632342976;20752.792472075387;20820.47948801292;20917.477063073544;20919.37241882746;983.1201075037944;992.8758905136858;1010.7523656704008;1015.4871789746131;1018.6434747838346;10664.146868250522;10951.890481095086;11079.113670906308;11115.221934464671;11310.886891131147;173571;173653;174087;174557;174590;41144.79427602843;41300.173996520505;41402.1719565613;41513;41592.792036040235;1207.9516819327127;1224.1492162946845;1240.2124650846777;1244.7821631214501;1250.2560976219136;24061;25455.418024755723;25603.487930241663;25817.483650327264;26004.34989125287;29413.411731765675;29780.255493612833;29786.404271914875;29790.851045744632;29817.25456863596;137034.3148284252;138176.30911845376;138764;138805.30597346948;139135;29781.851090744407;30059.549106763854;30110.849445752632;30156.69843301539;30215.165573508133;35128;35527.11182220465;35984.380702868955;36099;36406;26738;27094.082884315023;27571.31071723223;27627.58558621582;28755.993540226827;26298.342541436617;26756;26873.328166795985;27465.038723644575;27848.860755696904;30560.541591876583;30642.540361895037;30681.53977690381;30705.53941690921;30714.385712286075;25379.74620253774;26406.603900941118;26533.469330612894;26666;26835.060772872857;20249.493762656053;21839.126434942424;22113.080620916695;22266;22387.216447424264 14:28:21 INFO - PID 15150 | |2;jquery.html;417.97074204805676;429.23595999121557;433.0448027157385;445.3208856493849;448.2760342047593;17269.913650431747;17504.737428938577;17649.823501764993;18076.36732714355;18214.908925455355;18307.267709291613;18542.72185917209;19024.14391352389;19227.615447691038;19229.61540769184;5307.150855863063;5311.787528498855;5390.353157621091;5419.3225846769155;5429.755660995245;5288.444713305105;5419;5423.186522021689;5426.050441172799;5434.103372943459;5318.680879147244;5384.461553844623;5481.205225242337;5505.146702261156;5528.695921724304;5437.864053398657;5446.074167391533;5446.537044351196;5456.645318054314;5492.231087647732;4967.130752118364;4970.826021089245;4971.403431588233;4991.600671946236;4998.375203099613;21867.234646787445;22006.449838754;22196.11215551376;22237.110515579356;22389.21637742671;1571.756377761449;1597.4329113164893;1600.0479714569813;1616.8059832820136;1617.830127836572;14492;14667.853321466755;14931.70136597262;14995.100293982396;15177.16525591092;1990.5123244805116;2036.307655397172;2065.9483512912147;2071.8135367816967;2116.386247988082;75361.62319188369;82876;85990.57004714999;93708.53145734296;95494;11410.714732131597;11416.486258118404;11526.423678816025;11605.361705106301;11662;15858.762118568231;15882.285297161656;16054.919725401533;16114.355425783071;16115.597110072107;7887.645055972495;7921.1682773307975;8130.512169269863;8175.100738918714;8211.876821847676;7340.376068034277;7405.259474052552;7519.511231769918;7672.42456815741;7674.232576742393;7068.858622827514;7069;7170.4980651354945;7183.138023437116;7241.963790181121;2091.7385326834146;2114.2600089968696;2127.7872212778598;2159.3737816033176;2200.7249093863265;835.8746188071838;863.7236084452915;874.6326542852017;893.0533634347612;895.4358753984948;16435.63069570735;17363.65272694539;17417.129143542774;17476.650466990588;17490.912545437444;861.5261606116611;890.3678388344348;902.4269588811152;909.2998391238841;910.7905181808221;8845.778855528535;8964.820703585892;9178.541072946326;9287;9363.719088427359;352740;352772;353397;361668;362993;72397.6380118096;73396.63301683457;74740;74922.62538687272;76111;1086.8424078508572;1094.458243169636;1136.5965082395796;1139.0887290167832;1151.8732939376662;17323.653526929138;17399.652006960045;17612.647747045245;18202.089895505436;18542.721859172394;36882.44676329911;37466.43800342942;38001.80999094987;38238;38378.808105959295;48164.759176203894;48417;48477.515224848714;48533.27200092072;50728.492715072374;8426.789330266793;8460.746177614681;8706.782330441536;8785.560721963748;8952.910470895207;12145;12396.938015310227;12413.44139513706;13237.205767653586;13331;10309.381437113498;10541.262111652111;10649.787004259717;10665.093467055076;11320.716982075513;10094.545745441326;10137.898621013695;10175.89824101779;10228.335158214692;10702.411367374869;10772.946135269274;10841.728956775829;10859.131269498263;11086.501107450023;11926.224795388272;8125.349972002107;8289.461185022954;8344.457610255315;8361.66553337884;8441.66233350659;10002.749931251778;10314.381137131797;10426.573322113312;10485.37087774736;11684.824727629262 14:28:21 INFO - PID 15150 | |3;mootools.html;1226.1784604315108;1288.3365066990502;1296.053880667113;1299.181515645144;1304.6216597186817;10246.487675616218;10658.253922225427;10659.200559958004;10695.251332406735;10978.396188209645;10560.471976401188;10657.147428205744;10713.571457141705;10727.731806704836;10729;1965.4496740912568;2007.5483016321284;2009.4172689919906;2018.7678416982014;2018.8384929205702;2146.495573540217;2198.3404978506464;2203.790639889208;2214.645656694929;2217.8558393704357;2186.6501359782437;2197.28588208832;2248.662700594916;2249.7862703043184;2255.4474153832334;2182.5416662500893;2224.8331375146927;2225.2545397291847;2225.276785044859;2227.0535022615322;2072.782357852419;2191.298784388996;2232.3079845248026;2244.102359056374;2244.5959727249087;10388.324758890723;10483.68548943533;10489;10491.475426228735;10504.36973781568;5761.539076873882;5981.491573216282;5989.700514974277;5996.370381109964;6004.489618382443;3293.440115180425;3477.200243943907;3535.982320088409;3556.5376501054957;3584.444411116281;1066.6799960011965;1110.9611163609236;1121.265571050963;1125.2629527659396;1130.3218069158438;15452.227388630523;15637.061776293573;15643.90492665514;15644.296006679726;15646.452374166849;4624.560666736655;4746.881327966759;4952.059108769322;4960.255961605788;5045.041442125985;10525.947370263253;10529.789404211873;10541.84187237192;10554.683359499228;10560.366378017343;5694.715264236855;5699.287589051369;5703.401142879938;5704.3154821421695;5706.71466426677;5164.483551644806;5229.398619158769;5292.179712144623;5301.469853014668;5322.935412917354;3550.9644903550634;3669.816509174584;3671.1923376857585;3707.647773461517;3760.2103558252525;1092.6831218946415;1101.6750058732694;1102.9007389334997;1114.5207560748793;1117.8826223246604;654.9836254093591;674.5177198303237;677.3328271652418;699.4124935054579;703.9049728286718;5416.51251387377;5442.891142177214;5521.668699878021;5670.036093864053;5713.143028545752;532.0635681201114;532.6550460088308;535.8178219405421;536.8094326514109;537.8601563593494;3326.3513614844874;3346.7991920484847;3372.4941258811373;3406.2846802171325;3479.6172421033666;13504.797428038588;13754.243516606482;14105.717885642229;14127.434902603985;14128.222947737768;13785.793213101811;13919.443222270997;14058.086224395585;14104.71790564183;14134;7269.454790890704;7565.659545320474;7641.961790191013;7681.923180768121;7697.230276972258;5353.598480113929;5389.865253368697;5556.638818476786;5640.802571909963;5806.738696758741;11533.423328833356;12021.459034343301;12185.817212741993;12210.633680989584;12736.6815829605;12402.379881006094;12593.93703031479;12625.747485050431;12672.809907851206;12764.936175319064;7166.7458194816745;7365.889511657222;7366.447516436181;7371.4102871769055;7383.852322953619;9750.122488976027;9761.023897610183;9836.901630983599;9864.112229899343;9898;8204.384671149568;8456.450330728483;8464.788380290542;8507.276881465144;8586.82826343457;8279.83440331178;8357.791055223668;8424.115467875785;8439.240468357877;8562.57187140653;7080.964595176991;7163.570185788869;7197.712091516491;7266.564006159648;7626.847463050819;5457.808976685797;5519.475649813261;5570.442955704397;5651.519620832275;5770;5661.801836935688;5684.403137670485;5710.714464276853;5799.985002624609;5809.070548712186 14:28:21 INFO - PID 15150 | |4;prototype.html;376.27003612990796;383.6719604737949;393.9803009849507;398.7069503914622;400.88374371432286;5473.644213126144;5602.842905481389;5604.551635869131;5630.380658127603;5663;5361.490658387447;5397.541208997231;5403.864903377417;5424.105022671254;5436.456354364562;4136.214119317335;4148.751074935513;4148.937765933513;4151.97924010381;4160.06398560323;4017.493439960015;4147.896302592444;4174.582541745832;4175.791210439481;4182.038131229819;4097.44684467596;4108.3221268490815;4112.568180341066;4129.6076872697195;4142.493791256292;4101.22076805409;4114.136031433402;4119.423280740713;4146.025683964266;4150.439690641755;3493.899421682162;3618.9276214475562;3624.2026754114054;3627.9818600907092;3632.1827588792576;5385.569154467633;5403.189521571796;5406.378266499363;5413.783448662049;5446.183072539111;4840.685355451919;4878.780454879539;4887.291342755316;4894.265860120975;4897.510248975074;5730.455606717397;5819.388964158745;5828.795992140297;5861.267341582302;5871.775917527392;4005.838306891027;4007.9178621771957;4015.4779878615886;4028;4029.81865816039;5984.7606095756555;6077.574569780118;6109.816705498886;6147.538934579924;6250.624962502265;4089.325261331847;4093.9151124951914;4106;4106.691998100155;4111.506619205715;4185.414042034117;4187.350960601112;4187.832486700498;4192.601702838226;4194.538600753915;4712.246040633482;4776.355192049098;4783.689060211075;4831.444383895827;4850.466448690641;5818.981678206297;5819.912701309484;5827.94172058274;5834;5848.824535263949;1417.3692706745605;1445.869871711551;1446.992765036168;1447.9719399226456;1449.4347204590217;932.1563984593953;953.1707414549248;959.932804703664;966.1739212972948;971.9611215551299;5068.327451940851;5072.087024335581;5084.949150508448;5087.26234695967;5090.440051594322;6076.5442591805795;6082.57421980466;6104.11490333908;6104.314101795196;6122.66325352101;4885.291632713237;5035.647504674637;5040.218766091261;5043.083628221252;5077.822276220315;3204.839758012137;3210.9357812843614;3225.451673215559;3233.207864073317;3238.7085162335034;5337.306150200449;5548.361938377057;5563.248961390242;5582.441755824466;5601.383847776741;6193.628382297076;6218;6246.15676883624;6252.812415627538;6261.9373806262265;5590.580706447033;5593.468620481048;5595.328560572594;5605.943940560624;5608.523275521545;5852.970735146297;5926.844265368211;6027.728752206249;6030.185924900083;6074.271087469532;5948.762049517971;5955;5959.1657167995645;5978.551608629457;6002.369751176064;5353.277307563585;5573.5819813513335;5585.078462053878;5586.910552442235;5600.299962504687;4060.3706425504092;4144.834206631822;4144.8756537303925;4150.252954468225;4159.10579225468;5968.940310596839;6079.513638908788;6137.631742095488;6141;6153.784617538365;5863.618864773776;5871.6770577618645;5885.646861188342;5896.9115463268945;5899.557533185114;5866.266716660418;5876.1773351729935;5876.559258055749;5884.235049443545;5899.91150132757;5665.716714164193;5802.750459742558;5836.562257830595;5842.678652673973;5846.94153058464;5947.710131599452;5964.343922168471;5966.433188847052;5986.850328741642;6000.8799824004145;5609.663420194802;5684.914726279192;5756.50330913957;5775.27809023872;5795.971020144872 14:28:21 INFO - PID 15150 | |5;yui.html;704.7674267491728;720.099875156055;733.7431898835407;745.1468069060926;749.6476655971693;11954.760904781899;12449;12993.870061299383;13903.096298740575;13910.095843770148;13628.795568066487;14001.439942402292;14018.439262429516;14092.36584353704;14186.645333866658;862.9309655227582;885.5262434597491;887.1306120002401;887.4808237181256;888.2760550151638;877.978050548735;885;886.3308202307281;886.4193952960821;889.7997950461126;941.3692825806726;941.9434833909953;948.5541795356172;951.048951048951;951.8048799996019;932.6409332407004;937.9577918993662;938.8826396700413;940.5344354544476;941.5480569326693;689.3072462175481;690.6788343420284;691.6852831961445;691.7060249393987;692.7713854428026;13513.256770877599;13677.179369237778;13901.16593004423;14265.928670356685;14492.637684057878;13699.726005479934;14265.857341426557;14436.566902992927;14759.631009224748;14803.555893323217;12135.514579416813;12741.554045608453;14187.219702916336;14356.64108397288;14463.20452375119;2832.603435519029;2842.2325971987448;2855.6287682601337;2862.069827306134;2876.1515352970923;71967;73362;73625.8956115664;73959;75313;12318.384080795924;12394.938025309995;12525.498980040878;12536.623901282976;12557.497700092077;20984.26555070565;21138.682919756215;21194.788052119282;21246.78753212448;21405.35783926485;6036.396360364016;6328.905066424008;6518.511111666644;6551.934480655228;6573.769918052941;2985.850707464618;3016.1253236561593;3047.024952015334;3052.0386078385236;3058.8623511942014;3478.89563313101;3496.0910163357203;3535.381308271042;3539.2036791721657;3603.045193023851;742.9331360177501;762.1578156137389;767.6967597798838;770.0643717882688;770.9190534993745;590.3683059126694;594.8275000249965;609.8353444569941;616.1558664629397;631.0565704272143;9493.525323733786;9972.700818975442;10264.692059238234;10348.948255258827;10360.585576577003;582.4786815799836;591.5799782154633;592.8340064781868;598.4015984015984;598.9970050149722;4455.086707225011;4490.640748740093;4563.931541026887;4617.7691115444095;4662.207424737802;61409.692951534955;62048.37951620426;62149.37850621436;63590.36409635937;64809;55909.440905590425;56718;56967.14549281764;56975.71512142495;57776.71111644415;49766.253506197434;49817.25274120891;50158.74920625446;50692.74653626782;51251.23123153156;8883.289336853166;9176.495292758962;9200.539973001458;9317.11487408695;9556.665516706882;26936.32659183536;27129.86435067812;27352.72647273502;27435.31411714723;27686;31739;31806;31823.363532728752;31880.202994925312;32414.027579172664;11377.54489820398;11571;11574.942125289657;11607.709807254887;11880.584179553674;15076.396944122112;15147.242637868283;15775.447859325328;16112.758308625615;16294;13915.304234788422;14082;14530.200838953959;14561.708765824837;14662.26688665541;13492.865071349554;13567;13694.041417100707;13761.14224579669;13954.441822327399;13420.060595758594;13422.865771342162;13490.865091349353;13586.45654173822;14275.64310892236;10674.573017079541;10984.121270298518;11142.052925501423;11227.71930701739;11345.432728363383;11266.267692599955;11307.265027773497;12097.939510302393;12216.572419965258;12871.099023068295 14:28:21 INFO - PID 15150 | __end_tp_report 14:28:21 INFO - PID 15150 | __start_cc_report 14:28:21 INFO - PID 15150 | _x_x_mozilla_cycle_collect,296 14:28:21 INFO - PID 15150 | __end_cc_report 14:28:21 INFO - PID 15150 | __startTimestamp1495056501261__endTimestamp 14:28:21 INFO - PID 15150 | 14:28:21 INFO - PID 15150 | ------- Summary: start ------- 14:28:21 INFO - PID 15150 | Number of tests: 6 14:28:21 INFO - PID 15150 | 14:28:21 INFO - PID 15150 | [#0] dojo.html Cycles:165 Average:5252.20 Median:5351.49 stddev:619.31 (11.6%) stddev-sans-first:587.67 14:28:21 INFO - PID 15150 | Values: 2689.4 2705.5 2724.7 2733.2 2737.3 5223.8 5226.9 5239.8 5266.1 5313.3 5308.9 5320.4 5328.2 5394.5 5406.8 4714.4 4725.0 4731.6 4758.1 4803.4 4665.3 4760.3 4787.0 4798.2 4853.1 4657.1 4716.6 4731.4 4731.8 4778.6 4727.8 4736.1 4776.2 4798.3 4808.8 4645.5 4681.6 4688.5 4691.6 4748.0 5211.4 5230.6 5304.2 5310.0 5326.7 5691.9 5746.4 5799.6 5821.9 5834.0 5756.3 5767.5 5774.1 5795.6 5797.0 5324.5 5325.2 5333.3 5348.6 5390.6 5842.5 5929.3 5932.1 5946.9 5950.0 5567.1 5575.0 5582.2 5584.3 5587.2 5665.0 5666.1 5686.2 5710.3 5789.2 5736.0 5744.5 5749.3 5763.3 5789.0 5726.9 5743.2 5744.4 5749.7 5762.6 4812.4 4817.0 4878.6 4905.0 4908.3 4213.2 4215.7 4262.6 4276.6 4286.1 4844.9 4845.0 4866.8 4876.6 4877.2 5709.0 5715.4 5793.4 5802.8 5826.4 4771.0 4843.0 4843.4 4860.1 4882.6 5185.2 5210.5 5214.3 5215.4 5232.6 5332.5 5334.6 5335.3 5335.7 5339.9 5705.9 5802.6 5814.9 5815.2 5865.7 5192.8 5261.0 5296.2 5297.5 5325.8 5632.2 5677.9 5703.4 5729.6 5770.9 5673.7 5762.7 5790.6 5803.7 5804.3 5458.4 5578.9 5579.9 5586.8 5592.9 5573.8 5585.3 5594.8 5596.2 5606.5 5457.8 5520.6 5532.8 5537.4 5540.8 5602.1 5608.2 5619.6 5630.0 5642.8 5351.5 5455.9 5467.5 5474.2 5477.3 14:28:21 INFO - PID 15150 | 14:28:21 INFO - PID 15150 | [#1] ext.html Cycles:180 Average:29755.24 Median:2993.70 stddev:39103.76 (1306.2%) stddev-sans-first:39152.76 14:28:21 INFO - PID 15150 | Values: 740.9 759.4 1136.7 1181.0 1187.8 33758.7 34559.5 34624.5 34652.7 34660.8 32170.2 32385.4 32489.8 32497.2 32506.8 6734.9 6887.3 6910.1 6911.1 6920.6 6906.9 7031.5 7041.5 7051.4 7051.7 7029.8 7051.5 7066.4 7071.2 7086.4 6976.5 6983.5 7013.8 7044.5 7058.4 6867.3 6917.6 6921.7 6922.9 6926.9 30704.0 31294.2 31295.0 31402.5 31420.5 2954.9 2985.4 2991.1 2992.1 2995.3 24138.2 24373.1 24504.3 24505.1 24591.3 3123.1 3135.4 3152.1 3159.6 3179.1 136837.3 137745.3 138529.0 139417.0 149626.0 38416.2 38420.4 38534.8 38535.1 38550.4 39923.6 40393.4 43217.8 43965.8 43980.8 13349.5 13356.1 13361.7 13408.4 13494.6 10702.6 10803.4 10815.3 10834.2 10872.5 12601.6 12675.4 12784.4 12788.6 12894.6 5446.3 5497.5 5497.6 5499.3 5532.4 874.7 877.0 917.0 927.4 935.1 19456.7 20752.8 20820.5 20917.5 20919.4 983.1 992.9 1010.8 1015.5 1018.6 10664.1 10951.9 11079.1 11115.2 11310.9 173571.0 173653.0 174087.0 174557.0 174590.0 41144.8 41300.2 41402.2 41513.0 41592.8 1208.0 1224.1 1240.2 1244.8 1250.3 24061.0 25455.4 25603.5 25817.5 26004.3 29413.4 29780.3 29786.4 29790.9 29817.3 137034.3 138176.3 138764.0 138805.3 139135.0 29781.9 30059.5 30110.8 30156.7 30215.2 35128.0 35527.1 35984.4 36099.0 36406.0 26738.0 27094.1 27571.3 27627.6 28756.0 26298.3 26756.0 26873.3 27465.0 27848.9 30560.5 30642.5 30681.5 30705.5 30714.4 25379.7 26406.6 26533.5 26666.0 26835.1 20249.5 21839.1 22113.1 22266.0 22387.2 14:28:21 INFO - PID 15150 | 14:28:21 INFO - PID 15150 | [#2] jquery.html Cycles:180 Average:24458.76 Median:37174.44 stddev:59372.84 (159.7%) stddev-sans-first:59511.96 14:28:21 INFO - PID 15150 | Values: 418.0 429.2 433.0 445.3 448.3 17269.9 17504.7 17649.8 18076.4 18214.9 18307.3 18542.7 19024.1 19227.6 19229.6 5307.2 5311.8 5390.4 5419.3 5429.8 5288.4 5419.0 5423.2 5426.1 5434.1 5318.7 5384.5 5481.2 5505.1 5528.7 5437.9 5446.1 5446.5 5456.6 5492.2 4967.1 4970.8 4971.4 4991.6 4998.4 21867.2 22006.4 22196.1 22237.1 22389.2 1571.8 1597.4 1600.0 1616.8 1617.8 14492.0 14667.9 14931.7 14995.1 15177.2 1990.5 2036.3 2065.9 2071.8 2116.4 75361.6 82876.0 85990.6 93708.5 95494.0 11410.7 11416.5 11526.4 11605.4 11662.0 15858.8 15882.3 16054.9 16114.4 16115.6 7887.6 7921.2 8130.5 8175.1 8211.9 7340.4 7405.3 7519.5 7672.4 7674.2 7068.9 7069.0 7170.5 7183.1 7242.0 2091.7 2114.3 2127.8 2159.4 2200.7 835.9 863.7 874.6 893.1 895.4 16435.6 17363.7 17417.1 17476.7 17490.9 861.5 890.4 902.4 909.3 910.8 8845.8 8964.8 9178.5 9287.0 9363.7 352740.0 352772.0 353397.0 361668.0 362993.0 72397.6 73396.6 74740.0 74922.6 76111.0 1086.8 1094.5 1136.6 1139.1 1151.9 17323.7 17399.7 17612.6 18202.1 18542.7 36882.4 37466.4 38001.8 38238.0 38378.8 48164.8 48417.0 48477.5 48533.3 50728.5 8426.8 8460.7 8706.8 8785.6 8952.9 12145.0 12396.9 12413.4 13237.2 13331.0 10309.4 10541.3 10649.8 10665.1 11320.7 10094.5 10137.9 10175.9 10228.3 10702.4 10772.9 10841.7 10859.1 11086.5 11926.2 8125.3 8289.5 8344.5 8361.7 8441.7 10002.7 10314.4 10426.6 10485.4 11684.8 14:28:21 INFO - PID 15150 | 14:28:21 INFO - PID 15150 | [#3] mootools.html Cycles:180 Average:6382.72 Median:3478.41 stddev:4211.11 (121.1%) stddev-sans-first:4205.10 14:28:21 INFO - PID 15150 | Values: 1226.2 1288.3 1296.1 1299.2 1304.6 10246.5 10658.3 10659.2 10695.3 10978.4 10560.5 10657.1 10713.6 10727.7 10729.0 1965.4 2007.5 2009.4 2018.8 2018.8 2146.5 2198.3 2203.8 2214.6 2217.9 2186.7 2197.3 2248.7 2249.8 2255.4 2182.5 2224.8 2225.3 2225.3 2227.1 2072.8 2191.3 2232.3 2244.1 2244.6 10388.3 10483.7 10489.0 10491.5 10504.4 5761.5 5981.5 5989.7 5996.4 6004.5 3293.4 3477.2 3536.0 3556.5 3584.4 1066.7 1111.0 1121.3 1125.3 1130.3 15452.2 15637.1 15643.9 15644.3 15646.5 4624.6 4746.9 4952.1 4960.3 5045.0 10525.9 10529.8 10541.8 10554.7 10560.4 5694.7 5699.3 5703.4 5704.3 5706.7 5164.5 5229.4 5292.2 5301.5 5322.9 3551.0 3669.8 3671.2 3707.6 3760.2 1092.7 1101.7 1102.9 1114.5 1117.9 655.0 674.5 677.3 699.4 703.9 5416.5 5442.9 5521.7 5670.0 5713.1 532.1 532.7 535.8 536.8 537.9 3326.4 3346.8 3372.5 3406.3 3479.6 13504.8 13754.2 14105.7 14127.4 14128.2 13785.8 13919.4 14058.1 14104.7 14134.0 7269.5 7565.7 7642.0 7681.9 7697.2 5353.6 5389.9 5556.6 5640.8 5806.7 11533.4 12021.5 12185.8 12210.6 12736.7 12402.4 12593.9 12625.7 12672.8 12764.9 7166.7 7365.9 7366.4 7371.4 7383.9 9750.1 9761.0 9836.9 9864.1 9898.0 8204.4 8456.5 8464.8 8507.3 8586.8 8279.8 8357.8 8424.1 8439.2 8562.6 7081.0 7163.6 7197.7 7266.6 7626.8 5457.8 5519.5 5570.4 5651.5 5770.0 5661.8 5684.4 5710.7 5800.0 5809.1 14:28:21 INFO - PID 15150 | 14:28:21 INFO - PID 15150 | [#4] prototype.html Cycles:180 Average:4800.96 Median:5441.32 stddev:1437.71 (26.4%) stddev-sans-first:1402.86 14:28:21 INFO - PID 15150 | Values: 376.3 383.7 394.0 398.7 400.9 5473.6 5602.8 5604.6 5630.4 5663.0 5361.5 5397.5 5403.9 5424.1 5436.5 4136.2 4148.8 4148.9 4152.0 4160.1 4017.5 4147.9 4174.6 4175.8 4182.0 4097.4 4108.3 4112.6 4129.6 4142.5 4101.2 4114.1 4119.4 4146.0 4150.4 3493.9 3618.9 3624.2 3628.0 3632.2 5385.6 5403.2 5406.4 5413.8 5446.2 4840.7 4878.8 4887.3 4894.3 4897.5 5730.5 5819.4 5828.8 5861.3 5871.8 4005.8 4007.9 4015.5 4028.0 4029.8 5984.8 6077.6 6109.8 6147.5 6250.6 4089.3 4093.9 4106.0 4106.7 4111.5 4185.4 4187.4 4187.8 4192.6 4194.5 4712.2 4776.4 4783.7 4831.4 4850.5 5819.0 5819.9 5827.9 5834.0 5848.8 1417.4 1445.9 1447.0 1448.0 1449.4 932.2 953.2 959.9 966.2 972.0 5068.3 5072.1 5084.9 5087.3 5090.4 6076.5 6082.6 6104.1 6104.3 6122.7 4885.3 5035.6 5040.2 5043.1 5077.8 3204.8 3210.9 3225.5 3233.2 3238.7 5337.3 5548.4 5563.2 5582.4 5601.4 6193.6 6218.0 6246.2 6252.8 6261.9 5590.6 5593.5 5595.3 5605.9 5608.5 5853.0 5926.8 6027.7 6030.2 6074.3 5948.8 5955.0 5959.2 5978.6 6002.4 5353.3 5573.6 5585.1 5586.9 5600.3 4060.4 4144.8 4144.9 4150.3 4159.1 5968.9 6079.5 6137.6 6141.0 6153.8 5863.6 5871.7 5885.6 5896.9 5899.6 5866.3 5876.2 5876.6 5884.2 5899.9 5665.7 5802.8 5836.6 5842.7 5846.9 5947.7 5964.3 5966.4 5986.9 6000.9 5609.7 5684.9 5756.5 5775.3 5796.0 14:28:21 INFO - PID 15150 | 14:28:21 INFO - PID 15150 | [#5] yui.html Cycles:180 Average:15117.92 Median:31851.78 stddev:18113.69 (56.9%) stddev-sans-first:18132.17 14:28:21 INFO - PID 15150 | Values: 704.8 720.1 733.7 745.1 749.6 11954.8 12449.0 12993.9 13903.1 13910.1 13628.8 14001.4 14018.4 14092.4 14186.6 862.9 885.5 887.1 887.5 888.3 878.0 885.0 886.3 886.4 889.8 941.4 941.9 948.6 951.0 951.8 932.6 938.0 938.9 940.5 941.5 689.3 690.7 691.7 691.7 692.8 13513.3 13677.2 13901.2 14265.9 14492.6 13699.7 14265.9 14436.6 14759.6 14803.6 12135.5 12741.6 14187.2 14356.6 14463.2 2832.6 2842.2 2855.6 2862.1 2876.2 71967.0 73362.0 73625.9 73959.0 75313.0 12318.4 12394.9 12525.5 12536.6 12557.5 20984.3 21138.7 21194.8 21246.8 21405.4 6036.4 6328.9 6518.5 6551.9 6573.8 2985.9 3016.1 3047.0 3052.0 3058.9 3478.9 3496.1 3535.4 3539.2 3603.0 742.9 762.2 767.7 770.1 770.9 590.4 594.8 609.8 616.2 631.1 9493.5 9972.7 10264.7 10348.9 10360.6 582.5 591.6 592.8 598.4 599.0 4455.1 4490.6 4563.9 4617.8 4662.2 61409.7 62048.4 62149.4 63590.4 64809.0 55909.4 56718.0 56967.1 56975.7 57776.7 49766.3 49817.3 50158.7 50692.7 51251.2 8883.3 9176.5 9200.5 9317.1 9556.7 26936.3 27129.9 27352.7 27435.3 27686.0 31739.0 31806.0 31823.4 31880.2 32414.0 11377.5 11571.0 11574.9 11607.7 11880.6 15076.4 15147.2 15775.4 16112.8 16294.0 13915.3 14082.0 14530.2 14561.7 14662.3 13492.9 13567.0 13694.0 13761.1 13954.4 13420.1 13422.9 13490.9 13586.5 14275.6 10674.6 10984.1 11142.1 11227.7 11345.4 11266.3 11307.3 12097.9 12216.6 12871.1 14:28:21 INFO - PID 15150 | -------- Summary: end -------- 14:28:21 INFO - PID 15150 | 14:28:22 INFO - TEST-INFO | 15150: exit 0 14:28:22 INFO - TEST-OK | dromaeo_css | took 1119441ms 14:28:22 INFO - TEST-START | kraken 14:28:22 INFO - operating with platform_type : linux_ 14:28:22 INFO - Initialising browser for kraken test... 14:28:22 INFO - TEST-INFO | started process 15587 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUgNer8/profile http://localhost:53588/getInfo.html) 14:28:22 INFO - PID 15587 | JavaScript warning: resource://gre/modules/addons/XPIProvider.jsm, line 2939: String.localeCompare is deprecated; use String.prototype.localeCompare instead 14:28:25 INFO - PID 15587 | __metrics Screen width/height:1600/1200 14:28:25 INFO - PID 15587 | colorDepth:24 14:28:25 INFO - PID 15587 | Browser inner width/height: 1024/695 14:28:25 INFO - PID 15587 | __metrics 14:28:27 INFO - TEST-INFO | 15587: exit 0 14:28:27 INFO - Browser initialized. 14:28:27 INFO - Running cycle 1/1 for kraken test... 14:28:27 INFO - TEST-INFO | started process 15780 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUgNer8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:28:39 INFO - PID 15780 | RSS: Main: 165679104 14:28:39 INFO - PID 15780 | 14:28:42 INFO - PID 15780 | Cycle 1(1): loaded http://localhost:53588/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53588/tests/kraken/driver.html?testName=audio-beat-detection) 14:28:43 INFO - PID 15780 | RSS: Main: 170582016 14:28:43 INFO - PID 15780 | 14:28:45 INFO - PID 15780 | Cycle 1(1): loaded http://localhost:53588/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53588/tests/kraken/driver.html?testName=audio-dft) 14:28:46 INFO - PID 15780 | RSS: Main: 170442752 14:28:46 INFO - PID 15780 | 14:28:49 INFO - PID 15780 | Cycle 1(1): loaded http://localhost:53588/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53588/tests/kraken/driver.html?testName=audio-fft) 14:28:50 INFO - PID 15780 | RSS: Main: 165621760 14:28:50 INFO - PID 15780 | 14:28:52 INFO - PID 15780 | Cycle 1(1): loaded http://localhost:53588/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53588/tests/kraken/driver.html?testName=audio-oscillator) 14:28:52 INFO - PID 15780 | RSS: Main: 166354944 14:28:52 INFO - PID 15780 | 14:28:55 INFO - PID 15780 | Cycle 1(1): loaded http://localhost:53588/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53588/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:28:55 INFO - PID 15780 | RSS: Main: 166932480 14:28:55 INFO - PID 15780 | 14:28:58 INFO - PID 15780 | Cycle 1(1): loaded http://localhost:53588/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53588/tests/kraken/driver.html?testName=imaging-darkroom) 14:28:59 INFO - PID 15780 | RSS: Main: 170557440 14:28:59 INFO - PID 15780 | 14:29:03 INFO - PID 15780 | Cycle 1(1): loaded http://localhost:53588/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53588/tests/kraken/driver.html?testName=imaging-desaturate) 14:29:03 INFO - PID 15780 | RSS: Main: 167981056 14:29:03 INFO - PID 15780 | 14:29:06 INFO - PID 15780 | Cycle 1(1): loaded http://localhost:53588/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53588/tests/kraken/driver.html?testName=json-parse-financial) 14:29:07 INFO - PID 15780 | RSS: Main: 169107456 14:29:07 INFO - PID 15780 | 14:29:08 INFO - PID 15780 | Cycle 1(1): loaded http://localhost:53588/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53588/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:29:09 INFO - PID 15780 | RSS: Main: 169467904 14:29:09 INFO - PID 15780 | 14:29:11 INFO - PID 15780 | Cycle 1(1): loaded http://localhost:53588/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53588/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:29:11 INFO - PID 15780 | RSS: Main: 169132032 14:29:11 INFO - PID 15780 | 14:29:14 INFO - PID 15780 | Cycle 1(1): loaded http://localhost:53588/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53588/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:29:14 INFO - PID 15780 | RSS: Main: 169590784 14:29:14 INFO - PID 15780 | 14:29:17 INFO - PID 15780 | Cycle 1(1): loaded http://localhost:53588/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53588/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:29:18 INFO - PID 15780 | RSS: Main: 169918464 14:29:18 INFO - PID 15780 | 14:29:21 INFO - PID 15780 | Cycle 1(1): loaded http://localhost:53588/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53588/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:29:22 INFO - PID 15780 | RSS: Main: 169598976 14:29:22 INFO - PID 15780 | 14:29:23 INFO - PID 15780 | Cycle 1(1): loaded http://localhost:53588/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53588/tests/kraken/driver.html?testName=ai-astar) 14:29:24 INFO - PID 15780 | RSS: Main: 171192320 14:29:24 INFO - PID 15780 | 14:29:24 INFO - PID 15780 | __start_tp_report 14:29:24 INFO - PID 15780 | _x_x_mozilla_page_load 14:29:24 INFO - PID 15780 | _x_x_mozilla_page_load_details 14:29:24 INFO - PID 15780 | |i|pagename|runs| 14:29:24 INFO - PID 15780 | |0;ai-astar;104;114;114;113;113;114;113;111;111;113 14:29:24 INFO - PID 15780 | |1;audio-beat-detection;153;132;126;169;123;127;126;129;149;123 14:29:24 INFO - PID 15780 | |2;audio-dft;164;165;166;163;164;167;180;164;164;164 14:29:24 INFO - PID 15780 | |3;audio-fft;75;76;76;110;76;76;75;75;98;76 14:29:24 INFO - PID 15780 | |4;audio-oscillator;83;84;100;84;85;84;100;83;84;109 14:29:24 INFO - PID 15780 | |5;imaging-gaussian-blur;114;117;114;114;114;114;115;114;119;115 14:29:24 INFO - PID 15780 | |6;imaging-darkroom;151;153;155;150;154;151;152;152;152;150 14:29:24 INFO - PID 15780 | |7;imaging-desaturate;94;95;95;95;95;95;95;95;94;95 14:29:24 INFO - PID 15780 | |8;json-parse-financial;56;57;60;56;57;57;57;56;56;58 14:29:24 INFO - PID 15780 | |9;json-stringify-tinderbox;56;56;56;57;57;58;56;56;57;56 14:29:24 INFO - PID 15780 | |10;stanford-crypto-aes;92;84;89;88;83;85;83;83;85;91 14:29:24 INFO - PID 15780 | |11;stanford-crypto-ccm;137;149;135;135;136;135;141;139;187;136 14:29:24 INFO - PID 15780 | |12;stanford-crypto-pbkdf2;186;199;184;192;193;194;190;191;193;204 14:29:24 INFO - PID 15780 | |13;stanford-crypto-sha256-iterative;75;74;80;77;76;78;79;72;72;85 14:29:24 INFO - PID 15780 | __end_tp_report 14:29:24 INFO - PID 15780 | __start_cc_report 14:29:24 INFO - PID 15780 | _x_x_mozilla_cycle_collect,789 14:29:24 INFO - PID 15780 | __end_cc_report 14:29:24 INFO - PID 15780 | __startTimestamp1495056564141__endTimestamp 14:29:24 INFO - PID 15780 | 14:29:24 INFO - PID 15780 | ------- Summary: start ------- 14:29:24 INFO - PID 15780 | Number of tests: 14 14:29:24 INFO - PID 15780 | 14:29:24 INFO - PID 15780 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.00 stddev:3.02 (2.7%) stddev-sans-first:1.17 14:29:24 INFO - PID 15780 | Values: 104.0 114.0 114.0 113.0 113.0 114.0 113.0 111.0 111.0 113.0 14:29:24 INFO - PID 15780 | 14:29:24 INFO - PID 15780 | [#1] audio-beat-detection Cycles:10 Average:135.70 Median:130.50 stddev:15.74 (12.1%) stddev-sans-first:15.40 14:29:24 INFO - PID 15780 | Values: 153.0 132.0 126.0 169.0 123.0 127.0 126.0 129.0 149.0 123.0 14:29:24 INFO - PID 15780 | 14:29:24 INFO - PID 15780 | [#2] audio-dft Cycles:10 Average:166.10 Median:164.50 stddev:5.02 (3.1%) stddev-sans-first:5.27 14:29:24 INFO - PID 15780 | Values: 164.0 165.0 166.0 163.0 164.0 167.0 180.0 164.0 164.0 164.0 14:29:24 INFO - PID 15780 | 14:29:24 INFO - PID 15780 | [#3] audio-fft Cycles:10 Average:81.30 Median:76.00 stddev:12.30 (16.2%) stddev-sans-first:12.84 14:29:24 INFO - PID 15780 | Values: 75.0 76.0 76.0 110.0 76.0 76.0 75.0 75.0 98.0 76.0 14:29:24 INFO - PID 15780 | 14:29:24 INFO - PID 15780 | [#4] audio-oscillator Cycles:10 Average:89.60 Median:84.00 stddev:9.58 (11.4%) stddev-sans-first:9.86 14:29:24 INFO - PID 15780 | Values: 83.0 84.0 100.0 84.0 85.0 84.0 100.0 83.0 84.0 109.0 14:29:24 INFO - PID 15780 | 14:29:24 INFO - PID 15780 | [#5] imaging-gaussian-blur Cycles:10 Average:115.00 Median:114.50 stddev:1.70 (1.5%) stddev-sans-first:1.76 14:29:24 INFO - PID 15780 | Values: 114.0 117.0 114.0 114.0 114.0 114.0 115.0 114.0 119.0 115.0 14:29:24 INFO - PID 15780 | 14:29:24 INFO - PID 15780 | [#6] imaging-darkroom Cycles:10 Average:152.00 Median:152.00 stddev:1.63 (1.1%) stddev-sans-first:1.69 14:29:24 INFO - PID 15780 | Values: 151.0 153.0 155.0 150.0 154.0 151.0 152.0 152.0 152.0 150.0 14:29:24 INFO - PID 15780 | 14:29:24 INFO - PID 15780 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 14:29:24 INFO - PID 15780 | Values: 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 14:29:24 INFO - PID 15780 | 14:29:24 INFO - PID 15780 | [#8] json-parse-financial Cycles:10 Average:57.00 Median:57.00 stddev:1.25 (2.2%) stddev-sans-first:1.27 14:29:24 INFO - PID 15780 | Values: 56.0 57.0 60.0 56.0 57.0 57.0 57.0 56.0 56.0 58.0 14:29:24 INFO - PID 15780 | 14:29:24 INFO - PID 15780 | [#9] json-stringify-tinderbox Cycles:10 Average:56.50 Median:56.50 stddev:0.71 (1.3%) stddev-sans-first:0.73 14:29:24 INFO - PID 15780 | Values: 56.0 56.0 56.0 57.0 57.0 58.0 56.0 56.0 57.0 56.0 14:29:24 INFO - PID 15780 | 14:29:24 INFO - PID 15780 | [#10] stanford-crypto-aes Cycles:10 Average:86.30 Median:86.50 stddev:3.43 (4.0%) stddev-sans-first:2.96 14:29:24 INFO - PID 15780 | Values: 92.0 84.0 89.0 88.0 83.0 85.0 83.0 83.0 85.0 91.0 14:29:24 INFO - PID 15780 | 14:29:24 INFO - PID 15780 | [#11] stanford-crypto-ccm Cycles:10 Average:143.00 Median:138.00 stddev:16.05 (11.6%) stddev-sans-first:16.87 14:29:24 INFO - PID 15780 | Values: 137.0 149.0 135.0 135.0 136.0 135.0 141.0 139.0 187.0 136.0 14:29:24 INFO - PID 15780 | 14:29:24 INFO - PID 15780 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:192.60 Median:193.00 stddev:5.78 (3.0%) stddev-sans-first:5.61 14:29:24 INFO - PID 15780 | Values: 186.0 199.0 184.0 192.0 193.0 194.0 190.0 191.0 193.0 204.0 14:29:24 INFO - PID 15780 | 14:29:24 INFO - PID 15780 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:76.80 Median:77.50 stddev:3.97 (5.1%) stddev-sans-first:4.15 14:29:24 INFO - PID 15780 | Values: 75.0 74.0 80.0 77.0 76.0 78.0 79.0 72.0 72.0 85.0 14:29:24 INFO - PID 15780 | -------- Summary: end -------- 14:29:24 INFO - PID 15780 | 14:29:25 INFO - TEST-INFO | 15780: exit 0 14:29:25 INFO - TEST-OK | kraken | took 63287ms 14:29:25 INFO - SUITE-END | took 1182s 14:29:25 INFO - Completed test suite (00:19:43) 14:29:25 INFO - javascript benchmark 14:29:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6741.435147453106, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2689.435218604093, 2705.5400581901076, 2724.6866610339803, 2733.152722655976, 2737.2746222251108, 5223.764930578123, 5226.895462090756, 5239.8428047158595, 5266.052110620097, 5313.256144139818, 5308.893822123555, 5320.441353657859, 5328.20076988451, 5394.487523685253, 5406.810761623344, 4714.387129673138, 4724.952750472503, 4731.597814185799, 4758.119747846642, 4803.375561177042, 4665.300204969248, 4760.33355330254, 4787.042591481701, 4798.23228283473, 4853.077915196119, 4657.115148121846, 4716.599089077433, 4731.361266229083, 4731.787069581877, 4778.617710583145, 4727.76361181943, 4736.123817093849, 4776.211925032366, 4798.2802579613335, 4808.759562021885, 4645.535446455361, 4681.555252251031, 4688.507706690816, 4691.577758001797, 4747.976260118712, 5211.42674305826, 5230.555402790767, 5304.230886521472, 5309.973450132763, 5326.7070311132875, 5691.9146212806845, 5746.396628354005, 5799.594028417971, 5821.88356232873, 5834.0, 5756.309242890838, 5767.480926716616, 5774.133879918046, 5795.594308398414, 5797.043487824504, 5324.520793128637, 5325.174597937287, 5333.280007198979, 5348.625596208228, 5390.649607775482, 5842.503387212049, 5929.347771745104, 5932.139839723216, 5946.851328716817, 5950.047992321208, 5567.081431563746, 5574.9721251393485, 5582.162675598612, 5584.329880414376, 5587.189857470726, 5665.036943719578, 5666.121751128581, 5686.230752064321, 5710.314762228476, 5789.247397838254, 5736.024875771129, 5744.51171650406, 5749.281339832521, 5763.308402991668, 5789.015867302569, 5726.942730572724, 5743.195952566644, 5744.396838331915, 5749.655020698771, 5762.567807414461, 4812.374391329175, 4817.012512434942, 4878.585320247747, 4905.043516514245, 4908.312836202935, 4213.241616508996, 4215.683823713233, 4262.6376757975295, 4276.550962148992, 4286.057067445157, 4844.903101938012, 4844.975775121173, 4866.756662166948, 4876.609871210295, 4877.244027175793, 5708.971455142698, 5715.428457154251, 5793.420657934173, 5802.796902108406, 5826.359100498942, 4770.998090400985, 4842.951570484321, 4843.4430040545085, 4860.076585448754, 4882.633802464829, 5185.22221666753, 5210.505002024802, 5214.270002199695, 5215.374155101412, 5232.633715639945, 5332.493413125747, 5334.626576139788, 5335.253064570886, 5335.679859208305, 5339.9466005341, 5705.885882282248, 5802.622829516068, 5814.883702326015, 5815.2149459822385, 5865.677387743715, 5192.792288308426, 5261.0, 5296.152615581488, 5297.549708274686, 5325.786968521371, 5632.239647647515, 5677.914831277617, 5703.401142880104, 5729.598928075162, 5770.884582308414, 5673.659580425187, 5762.654240745569, 5790.5946583740415, 5803.7388317524965, 5804.332501762183, 5458.399576046711, 5578.86052848682, 5579.860503487445, 5586.77652893896, 5592.860178495407, 5573.832785016456, 5585.273914391266, 5594.804181853616, 5596.216529685766, 5606.495415412633, 5457.836264912059, 5520.613557050968, 5532.778688852401, 5537.446255374431, 5540.7783688652, 5602.1036634138345, 5608.2148499209325, 5619.550435965195, 5629.971850140723, 5642.774289028393, 5351.491608297206, 5455.863603409946, 5467.480589344006, 5474.2062400950845, 5477.260569823023], "value": 5206.507851024822, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.8814589665653, 759.4380158682575, 1136.727185475486, 1181.0433548825458, 1187.8277649740794, 33758.66241337586, 34559.48160777587, 34624.480632790466, 34652.65347346526, 34660.82669586648, 32170.195745106324, 32385.352292954125, 32489.83755081221, 32497.187570310754, 32506.837465812696, 6734.8653026939555, 6887.311268873098, 6910.101686780711, 6911.136107986502, 6920.584764914096, 6906.930930690704, 7031.50779445439, 7041.507094503361, 7051.400630946376, 7051.717931282768, 7029.82425439363, 7051.541649792773, 7066.434685225169, 7071.151461824588, 7086.362227399533, 6976.476764242702, 6983.546069505466, 7013.824654383656, 7044.471664625174, 7058.435325173974, 6867.3476019778045, 6917.619530925847, 6921.688524016431, 6922.930770692279, 6926.861462770767, 30704.0, 31294.21764455884, 31295.0, 31402.528962065586, 31420.528692069638, 2954.9409011819857, 2985.447692176954, 2991.0578167877047, 2992.132281638322, 2995.266159790843, 24138.155164569154, 24373.146939857197, 24504.264872053867, 24505.14232001889, 24591.262262132164, 3123.1411361875666, 3135.404273188087, 3152.0701393089093, 3159.57345758322, 3179.1257404213793, 136837.3158134213, 137745.311273444, 138529.0, 139416.99999999898, 149626.0, 38416.23167536689, 38420.42369364462, 38534.80732596319, 38535.14648535124, 38550.42174367387, 39923.60076399257, 40393.39409908854, 43217.783911080245, 43965.78017109894, 43980.78009609995, 13349.532766353132, 13356.131851429625, 13361.665958350924, 13408.396622152026, 13494.595162145151, 10702.625408110835, 10803.351798892092, 10815.297005694762, 10834.187435942336, 10872.510737016853, 12601.621951341474, 12675.429605667767, 12784.360781960864, 12788.616341509769, 12894.613161605166, 5446.346438427414, 5497.471163264863, 5497.642653227527, 5499.312585926759, 5532.3914369419335, 874.7419511244071, 876.9824603507894, 917.0050495212769, 927.3786563002805, 935.0976307862945, 19456.707632342976, 20752.792472075387, 20820.47948801292, 20917.477063073544, 20919.37241882746, 983.1201075037944, 992.8758905136858, 1010.7523656704008, 1015.4871789746131, 1018.6434747838346, 10664.146868250522, 10951.890481095086, 11079.113670906308, 11115.221934464671, 11310.886891131147, 173571.0, 173653.0, 174087.0, 174557.0, 174590.0, 41144.79427602843, 41300.173996520505, 41402.1719565613, 41513.0, 41592.792036040235, 1207.9516819327127, 1224.1492162946845, 1240.2124650846777, 1244.7821631214501, 1250.2560976219136, 24061.0, 25455.418024755723, 25603.487930241663, 25817.483650327264, 26004.34989125287, 29413.411731765675, 29780.255493612833, 29786.404271914875, 29790.851045744632, 29817.25456863596, 137034.3148284252, 138176.30911845376, 138764.0, 138805.30597346948, 139135.0, 29781.851090744407, 30059.549106763854, 30110.849445752632, 30156.69843301539, 30215.165573508133, 35128.0, 35527.11182220465, 35984.380702868955, 36099.0, 36406.0, 26738.0, 27094.082884315023, 27571.31071723223, 27627.58558621582, 28755.993540226827, 26298.342541436617, 26756.0, 26873.328166795985, 27465.038723644575, 27848.860755696904, 30560.541591876583, 30642.540361895037, 30681.53977690381, 30705.53941690921, 30714.385712286075, 25379.74620253774, 26406.603900941118, 26533.469330612894, 26666.0, 26835.060772872857, 20249.493762656053, 21839.126434942424, 22113.080620916695, 22266.0, 22387.216447424264], "value": 14603.697952228422, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [417.97074204805676, 429.23595999121557, 433.0448027157385, 445.3208856493849, 448.2760342047593, 17269.913650431747, 17504.737428938577, 17649.823501764993, 18076.36732714355, 18214.908925455355, 18307.267709291613, 18542.72185917209, 19024.14391352389, 19227.615447691038, 19229.61540769184, 5307.150855863063, 5311.787528498855, 5390.353157621091, 5419.3225846769155, 5429.755660995245, 5288.444713305105, 5419.0, 5423.186522021689, 5426.050441172799, 5434.103372943459, 5318.680879147244, 5384.461553844623, 5481.205225242337, 5505.146702261156, 5528.695921724304, 5437.864053398657, 5446.074167391533, 5446.537044351196, 5456.645318054314, 5492.231087647732, 4967.130752118364, 4970.826021089245, 4971.403431588233, 4991.600671946236, 4998.375203099613, 21867.234646787445, 22006.449838754, 22196.11215551376, 22237.110515579356, 22389.21637742671, 1571.756377761449, 1597.4329113164893, 1600.0479714569813, 1616.8059832820136, 1617.830127836572, 14492.0, 14667.853321466755, 14931.70136597262, 14995.100293982396, 15177.16525591092, 1990.5123244805116, 2036.307655397172, 2065.9483512912147, 2071.8135367816967, 2116.386247988082, 75361.62319188369, 82876.0, 85990.57004714999, 93708.53145734296, 95494.0, 11410.714732131597, 11416.486258118404, 11526.423678816025, 11605.361705106301, 11662.0, 15858.762118568231, 15882.285297161656, 16054.919725401533, 16114.355425783071, 16115.597110072107, 7887.645055972495, 7921.1682773307975, 8130.512169269863, 8175.100738918714, 8211.876821847676, 7340.376068034277, 7405.259474052552, 7519.511231769918, 7672.42456815741, 7674.232576742393, 7068.858622827514, 7069.0, 7170.4980651354945, 7183.138023437116, 7241.963790181121, 2091.7385326834146, 2114.2600089968696, 2127.7872212778598, 2159.3737816033176, 2200.7249093863265, 835.8746188071838, 863.7236084452915, 874.6326542852017, 893.0533634347612, 895.4358753984948, 16435.63069570735, 17363.65272694539, 17417.129143542774, 17476.650466990588, 17490.912545437444, 861.5261606116611, 890.3678388344348, 902.4269588811152, 909.2998391238841, 910.7905181808221, 8845.778855528535, 8964.820703585892, 9178.541072946326, 9287.0, 9363.719088427359, 352740.0, 352772.0, 353397.0, 361668.0, 362993.0, 72397.6380118096, 73396.63301683457, 74740.0, 74922.62538687272, 76111.0, 1086.8424078508572, 1094.458243169636, 1136.5965082395796, 1139.0887290167832, 1151.8732939376662, 17323.653526929138, 17399.652006960045, 17612.647747045245, 18202.089895505436, 18542.721859172394, 36882.44676329911, 37466.43800342942, 38001.80999094987, 38238.0, 38378.808105959295, 48164.759176203894, 48417.0, 48477.515224848714, 48533.27200092072, 50728.492715072374, 8426.789330266793, 8460.746177614681, 8706.782330441536, 8785.560721963748, 8952.910470895207, 12145.0, 12396.938015310227, 12413.44139513706, 13237.205767653586, 13331.0, 10309.381437113498, 10541.262111652111, 10649.787004259717, 10665.093467055076, 11320.716982075513, 10094.545745441326, 10137.898621013695, 10175.89824101779, 10228.335158214692, 10702.411367374869, 10772.946135269274, 10841.728956775829, 10859.131269498263, 11086.501107450023, 11926.224795388272, 8125.349972002107, 8289.461185022954, 8344.457610255315, 8361.66553337884, 8441.66233350659, 10002.749931251778, 10314.381137131797, 10426.573322113312, 10485.37087774736, 11684.824727629262], "value": 8887.010558602602, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1226.1784604315108, 1288.3365066990502, 1296.053880667113, 1299.181515645144, 1304.6216597186817, 10246.487675616218, 10658.253922225427, 10659.200559958004, 10695.251332406735, 10978.396188209645, 10560.471976401188, 10657.147428205744, 10713.571457141705, 10727.731806704836, 10729.0, 1965.4496740912568, 2007.5483016321284, 2009.4172689919906, 2018.7678416982014, 2018.8384929205702, 2146.495573540217, 2198.3404978506464, 2203.790639889208, 2214.645656694929, 2217.8558393704357, 2186.6501359782437, 2197.28588208832, 2248.662700594916, 2249.7862703043184, 2255.4474153832334, 2182.5416662500893, 2224.8331375146927, 2225.2545397291847, 2225.276785044859, 2227.0535022615322, 2072.782357852419, 2191.298784388996, 2232.3079845248026, 2244.102359056374, 2244.5959727249087, 10388.324758890723, 10483.68548943533, 10489.0, 10491.475426228735, 10504.36973781568, 5761.539076873882, 5981.491573216282, 5989.700514974277, 5996.370381109964, 6004.489618382443, 3293.440115180425, 3477.200243943907, 3535.982320088409, 3556.5376501054957, 3584.444411116281, 1066.6799960011965, 1110.9611163609236, 1121.265571050963, 1125.2629527659396, 1130.3218069158438, 15452.227388630523, 15637.061776293573, 15643.90492665514, 15644.296006679726, 15646.452374166849, 4624.560666736655, 4746.881327966759, 4952.059108769322, 4960.255961605788, 5045.041442125985, 10525.947370263253, 10529.789404211873, 10541.84187237192, 10554.683359499228, 10560.366378017343, 5694.715264236855, 5699.287589051369, 5703.401142879938, 5704.3154821421695, 5706.71466426677, 5164.483551644806, 5229.398619158769, 5292.179712144623, 5301.469853014668, 5322.935412917354, 3550.9644903550634, 3669.816509174584, 3671.1923376857585, 3707.647773461517, 3760.2103558252525, 1092.6831218946415, 1101.6750058732694, 1102.9007389334997, 1114.5207560748793, 1117.8826223246604, 654.9836254093591, 674.5177198303237, 677.3328271652418, 699.4124935054579, 703.9049728286718, 5416.51251387377, 5442.891142177214, 5521.668699878021, 5670.036093864053, 5713.143028545752, 532.0635681201114, 532.6550460088308, 535.8178219405421, 536.8094326514109, 537.8601563593494, 3326.3513614844874, 3346.7991920484847, 3372.4941258811373, 3406.2846802171325, 3479.6172421033666, 13504.797428038588, 13754.243516606482, 14105.717885642229, 14127.434902603985, 14128.222947737768, 13785.793213101811, 13919.443222270997, 14058.086224395585, 14104.71790564183, 14134.0, 7269.454790890704, 7565.659545320474, 7641.961790191013, 7681.923180768121, 7697.230276972258, 5353.598480113929, 5389.865253368697, 5556.638818476786, 5640.802571909963, 5806.738696758741, 11533.423328833356, 12021.459034343301, 12185.817212741993, 12210.633680989584, 12736.6815829605, 12402.379881006094, 12593.93703031479, 12625.747485050431, 12672.809907851206, 12764.936175319064, 7166.7458194816745, 7365.889511657222, 7366.447516436181, 7371.4102871769055, 7383.852322953619, 9750.122488976027, 9761.023897610183, 9836.901630983599, 9864.112229899343, 9898.0, 8204.384671149568, 8456.450330728483, 8464.788380290542, 8507.276881465144, 8586.82826343457, 8279.83440331178, 8357.791055223668, 8424.115467875785, 8439.240468357877, 8562.57187140653, 7080.964595176991, 7163.570185788869, 7197.712091516491, 7266.564006159648, 7626.847463050819, 5457.808976685797, 5519.475649813261, 5570.442955704397, 5651.519620832275, 5770.0, 5661.801836935688, 5684.403137670485, 5710.714464276853, 5799.985002624609, 5809.070548712186], "value": 4709.671903367992, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.27003612990796, 383.6719604737949, 393.9803009849507, 398.7069503914622, 400.88374371432286, 5473.644213126144, 5602.842905481389, 5604.551635869131, 5630.380658127603, 5663.0, 5361.490658387447, 5397.541208997231, 5403.864903377417, 5424.105022671254, 5436.456354364562, 4136.214119317335, 4148.751074935513, 4148.937765933513, 4151.97924010381, 4160.06398560323, 4017.493439960015, 4147.896302592444, 4174.582541745832, 4175.791210439481, 4182.038131229819, 4097.44684467596, 4108.3221268490815, 4112.568180341066, 4129.6076872697195, 4142.493791256292, 4101.22076805409, 4114.136031433402, 4119.423280740713, 4146.025683964266, 4150.439690641755, 3493.899421682162, 3618.9276214475562, 3624.2026754114054, 3627.9818600907092, 3632.1827588792576, 5385.569154467633, 5403.189521571796, 5406.378266499363, 5413.783448662049, 5446.183072539111, 4840.685355451919, 4878.780454879539, 4887.291342755316, 4894.265860120975, 4897.510248975074, 5730.455606717397, 5819.388964158745, 5828.795992140297, 5861.267341582302, 5871.775917527392, 4005.838306891027, 4007.9178621771957, 4015.4779878615886, 4028.0, 4029.81865816039, 5984.7606095756555, 6077.574569780118, 6109.816705498886, 6147.538934579924, 6250.624962502265, 4089.325261331847, 4093.9151124951914, 4106.0, 4106.691998100155, 4111.506619205715, 4185.414042034117, 4187.350960601112, 4187.832486700498, 4192.601702838226, 4194.538600753915, 4712.246040633482, 4776.355192049098, 4783.689060211075, 4831.444383895827, 4850.466448690641, 5818.981678206297, 5819.912701309484, 5827.94172058274, 5834.0, 5848.824535263949, 1417.3692706745605, 1445.869871711551, 1446.992765036168, 1447.9719399226456, 1449.4347204590217, 932.1563984593953, 953.1707414549248, 959.932804703664, 966.1739212972948, 971.9611215551299, 5068.327451940851, 5072.087024335581, 5084.949150508448, 5087.26234695967, 5090.440051594322, 6076.5442591805795, 6082.57421980466, 6104.11490333908, 6104.314101795196, 6122.66325352101, 4885.291632713237, 5035.647504674637, 5040.218766091261, 5043.083628221252, 5077.822276220315, 3204.839758012137, 3210.9357812843614, 3225.451673215559, 3233.207864073317, 3238.7085162335034, 5337.306150200449, 5548.361938377057, 5563.248961390242, 5582.441755824466, 5601.383847776741, 6193.628382297076, 6218.0, 6246.15676883624, 6252.812415627538, 6261.9373806262265, 5590.580706447033, 5593.468620481048, 5595.328560572594, 5605.943940560624, 5608.523275521545, 5852.970735146297, 5926.844265368211, 6027.728752206249, 6030.185924900083, 6074.271087469532, 5948.762049517971, 5955.0, 5959.1657167995645, 5978.551608629457, 6002.369751176064, 5353.277307563585, 5573.5819813513335, 5585.078462053878, 5586.910552442235, 5600.299962504687, 4060.3706425504092, 4144.834206631822, 4144.8756537303925, 4150.252954468225, 4159.10579225468, 5968.940310596839, 6079.513638908788, 6137.631742095488, 6141.0, 6153.784617538365, 5863.618864773776, 5871.6770577618645, 5885.646861188342, 5896.9115463268945, 5899.557533185114, 5866.266716660418, 5876.1773351729935, 5876.559258055749, 5884.235049443545, 5899.91150132757, 5665.716714164193, 5802.750459742558, 5836.562257830595, 5842.678652673973, 5846.94153058464, 5947.710131599452, 5964.343922168471, 5966.433188847052, 5986.850328741642, 6000.8799824004145, 5609.663420194802, 5684.914726279192, 5756.50330913957, 5775.27809023872, 5795.971020144872], "value": 4357.250860338739, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.7674267491728, 720.099875156055, 733.7431898835407, 745.1468069060926, 749.6476655971693, 11954.760904781899, 12449.0, 12993.870061299383, 13903.096298740575, 13910.095843770148, 13628.795568066487, 14001.439942402292, 14018.439262429516, 14092.36584353704, 14186.645333866658, 862.9309655227582, 885.5262434597491, 887.1306120002401, 887.4808237181256, 888.2760550151638, 877.978050548735, 885.0, 886.3308202307281, 886.4193952960821, 889.7997950461126, 941.3692825806726, 941.9434833909953, 948.5541795356172, 951.048951048951, 951.8048799996019, 932.6409332407004, 937.9577918993662, 938.8826396700413, 940.5344354544476, 941.5480569326693, 689.3072462175481, 690.6788343420284, 691.6852831961445, 691.7060249393987, 692.7713854428026, 13513.256770877599, 13677.179369237778, 13901.16593004423, 14265.928670356685, 14492.637684057878, 13699.726005479934, 14265.857341426557, 14436.566902992927, 14759.631009224748, 14803.555893323217, 12135.514579416813, 12741.554045608453, 14187.219702916336, 14356.64108397288, 14463.20452375119, 2832.603435519029, 2842.2325971987448, 2855.6287682601337, 2862.069827306134, 2876.1515352970923, 71967.0, 73362.0, 73625.8956115664, 73959.0, 75313.0, 12318.384080795924, 12394.938025309995, 12525.498980040878, 12536.623901282976, 12557.497700092077, 20984.26555070565, 21138.682919756215, 21194.788052119282, 21246.78753212448, 21405.35783926485, 6036.396360364016, 6328.905066424008, 6518.511111666644, 6551.934480655228, 6573.769918052941, 2985.850707464618, 3016.1253236561593, 3047.024952015334, 3052.0386078385236, 3058.8623511942014, 3478.89563313101, 3496.0910163357203, 3535.381308271042, 3539.2036791721657, 3603.045193023851, 742.9331360177501, 762.1578156137389, 767.6967597798838, 770.0643717882688, 770.9190534993745, 590.3683059126694, 594.8275000249965, 609.8353444569941, 616.1558664629397, 631.0565704272143, 9493.525323733786, 9972.700818975442, 10264.692059238234, 10348.948255258827, 10360.585576577003, 582.4786815799836, 591.5799782154633, 592.8340064781868, 598.4015984015984, 598.9970050149722, 4455.086707225011, 4490.640748740093, 4563.931541026887, 4617.7691115444095, 4662.207424737802, 61409.692951534955, 62048.37951620426, 62149.37850621436, 63590.36409635937, 64809.0, 55909.440905590425, 56718.0, 56967.14549281764, 56975.71512142495, 57776.71111644415, 49766.253506197434, 49817.25274120891, 50158.74920625446, 50692.74653626782, 51251.23123153156, 8883.289336853166, 9176.495292758962, 9200.539973001458, 9317.11487408695, 9556.665516706882, 26936.32659183536, 27129.86435067812, 27352.72647273502, 27435.31411714723, 27686.0, 31739.0, 31806.0, 31823.363532728752, 31880.202994925312, 32414.027579172664, 11377.54489820398, 11571.0, 11574.942125289657, 11607.709807254887, 11880.584179553674, 15076.396944122112, 15147.242637868283, 15775.447859325328, 16112.758308625615, 16294.0, 13915.304234788422, 14082.0, 14530.200838953959, 14561.708765824837, 14662.26688665541, 13492.865071349554, 13567.0, 13694.041417100707, 13761.14224579669, 13954.441822327399, 13420.060595758594, 13422.865771342162, 13490.865091349353, 13586.45654173822, 14275.64310892236, 10674.573017079541, 10984.121270298518, 11142.052925501423, 11227.71930701739, 11345.432728363383, 11266.267692599955, 11307.265027773497, 12097.939510302393, 12216.572419965258, 12871.099023068295], "value": 6768.841658467361, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1558.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 114.0, 113.0, 113.0, 114.0, 113.0, 111.0, 111.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 132.0, 126.0, 169.0, 123.0, 127.0, 126.0, 129.0, 149.0, 123.0], "value": 135.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 166.0, 163.0, 164.0, 167.0, 180.0, 164.0, 164.0, 164.0], "value": 166.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 76.0, 76.0, 110.0, 76.0, 76.0, 75.0, 75.0, 98.0, 76.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 100.0, 84.0, 85.0, 84.0, 100.0, 83.0, 84.0, 109.0], "value": 89.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 114.0, 114.0, 114.0, 114.0, 115.0, 114.0, 119.0, 115.0], "value": 115.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 153.0, 155.0, 150.0, 154.0, 151.0, 152.0, 152.0, 152.0, 150.0], "value": 152.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 57.0, 60.0, 56.0, 57.0, 57.0, 57.0, 56.0, 56.0, 58.0], "value": 57.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 56.0, 57.0, 57.0, 58.0, 56.0, 56.0, 57.0, 56.0], "value": 56.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 84.0, 89.0, 88.0, 83.0, 85.0, 83.0, 83.0, 85.0, 91.0], "value": 86.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 149.0, 135.0, 135.0, 136.0, 135.0, 141.0, 139.0, 187.0, 136.0], "value": 143.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 199.0, 184.0, 192.0, 193.0, 194.0, 190.0, 191.0, 193.0, 204.0], "value": 192.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 80.0, 77.0, 76.0, 78.0, 79.0, 72.0, 72.0, 85.0], "value": 76.8, "unit": "score"}]}]} 14:29:25 INFO - Return code: 0 14:29:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:29:25 INFO - # TBPL SUCCESS # 14:29:25 INFO - Running post-action listener: _resource_record_post_action 14:29:25 INFO - [mozharness: 2017-05-17 21:29:25.923641Z] Finished run-tests step (success) 14:29:25 INFO - Running post-run listener: _resource_record_post_run 14:29:26 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 8192; Write bytes: 391491584; Read time: 184; Write time: 269500 14:29:26 INFO - TinderboxPrint: CPU usage
13.3% 14:29:26 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 184 14:29:26 INFO - TinderboxPrint: I/O write bytes / time
391,491,584 / 269,500 14:29:26 INFO - TinderboxPrint: CPU idle
8,300.1 (86.7%) 14:29:26 INFO - TinderboxPrint: CPU user
1,219.4 (12.7%) 14:29:26 INFO - TinderboxPrint: Swap in / out
0 / 0 14:29:26 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 107929600; Read time: 0; Write time: 113996 14:29:26 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 4096; Write bytes: 282984448; Read time: 180; Write time: 155480 14:29:26 INFO - Running post-run listener: _upload_blobber_files 14:29:26 INFO - Blob upload gear active. 14:29:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:29:26 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 14:29:26 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'] 14:29:26 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 14:29:26 INFO - (blobuploader) - INFO - Open directory for files ... 14:29:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:29:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:29:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:27 INFO - (blobuploader) - INFO - Done attempting. 14:29:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:29:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:29:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:29 INFO - (blobuploader) - INFO - Done attempting. 14:29:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:29:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:29:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:30 INFO - (blobuploader) - INFO - Done attempting. 14:29:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:29:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:29:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:29:33 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:29:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:29:33 INFO - (blobuploader) - INFO - Done attempting. 14:29:33 INFO - (blobuploader) - INFO - Iteration through files over. 14:29:33 INFO - Return code: 0 14:29:33 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:29:33 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:29:33 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4eb1a06440332b88930ea6b2585a81721b3821f1282db43c2e4f7ac1f3b14426daa9e7aec999308421928ae128babec7b3f801115eaac4b9618ebd34955c583", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b1559db3b3f6bc8f8b27fa60e8c4b39c3aa7461f843d193f45f744d2248735570ff648c54c48e2c8eb9f5072bd8485704443f53f8464bbedc3cc14a0314e7b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6563b2876320a2e677b1548a50bcf20eb57c5706971ca77e2913a96a9a220c0ae70aaba06a7a162cf0017cda23d3ded03d10bf9277a1c76bdd1698b21ce1c781", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6a67716761fb3ec9bc45d08927c4d19a2ffee9191daae44227486377ef07e83065829e6decffe3985d0c3aa69c594610797d491b5ae158117f3625637c45e54"} 14:29:33 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:29:33 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:29:33 INFO - Contents: 14:29:33 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4eb1a06440332b88930ea6b2585a81721b3821f1282db43c2e4f7ac1f3b14426daa9e7aec999308421928ae128babec7b3f801115eaac4b9618ebd34955c583", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b1559db3b3f6bc8f8b27fa60e8c4b39c3aa7461f843d193f45f744d2248735570ff648c54c48e2c8eb9f5072bd8485704443f53f8464bbedc3cc14a0314e7b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6563b2876320a2e677b1548a50bcf20eb57c5706971ca77e2913a96a9a220c0ae70aaba06a7a162cf0017cda23d3ded03d10bf9277a1c76bdd1698b21ce1c781", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6a67716761fb3ec9bc45d08927c4d19a2ffee9191daae44227486377ef07e83065829e6decffe3985d0c3aa69c594610797d491b5ae158117f3625637c45e54"} 14:29:33 INFO - Running post-run listener: copy_logs_to_upload_dir 14:29:33 INFO - Copying logs to upload dir... 14:29:33 INFO - mkdir: /builds/slave/test/build/upload/logs 14:29:33 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.309258 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2017-05-17 14:29:33.596957) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-17 14:29:33.601774) ========= 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=652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058 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/b4eb1a06440332b88930ea6b2585a81721b3821f1282db43c2e4f7ac1f3b14426daa9e7aec999308421928ae128babec7b3f801115eaac4b9618ebd34955c583", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b1559db3b3f6bc8f8b27fa60e8c4b39c3aa7461f843d193f45f744d2248735570ff648c54c48e2c8eb9f5072bd8485704443f53f8464bbedc3cc14a0314e7b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6563b2876320a2e677b1548a50bcf20eb57c5706971ca77e2913a96a9a220c0ae70aaba06a7a162cf0017cda23d3ded03d10bf9277a1c76bdd1698b21ce1c781", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6a67716761fb3ec9bc45d08927c4d19a2ffee9191daae44227486377ef07e83065829e6decffe3985d0c3aa69c594610797d491b5ae158117f3625637c45e54"} build_url:https://queue.taskcluster.net/v1/task/Qczh4UEwSlOVtGe5Cl_9oA/artifacts/public/build/target.tar.bz2 program finished with exit code 0 elapsedTime=0.011536 build_url: 'https://queue.taskcluster.net/v1/task/Qczh4UEwSlOVtGe5Cl_9oA/artifacts/public/build/target.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b4eb1a06440332b88930ea6b2585a81721b3821f1282db43c2e4f7ac1f3b14426daa9e7aec999308421928ae128babec7b3f801115eaac4b9618ebd34955c583", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3b1559db3b3f6bc8f8b27fa60e8c4b39c3aa7461f843d193f45f744d2248735570ff648c54c48e2c8eb9f5072bd8485704443f53f8464bbedc3cc14a0314e7b5", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6563b2876320a2e677b1548a50bcf20eb57c5706971ca77e2913a96a9a220c0ae70aaba06a7a162cf0017cda23d3ded03d10bf9277a1c76bdd1698b21ce1c781", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d6a67716761fb3ec9bc45d08927c4d19a2ffee9191daae44227486377ef07e83065829e6decffe3985d0c3aa69c594610797d491b5ae158117f3625637c45e54"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-17 14:29:33.629393) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 14:29:33.629711) ========= 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=652eb03db935cfc1c15ebda0000001ad-1495054969.411073-1132976058 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004467 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-17 14:29:33.711037) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-17 14:29:33.714376) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-17 14:29:33.714667) ========= ========= Total master_lag: 0.24 =========